-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Thu 2024-10-24 05:40:33 CST. --
Oct 24 05:39:00 volumio volumio[723]: info: Clearing queue after UPNP request
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::ClearQueue
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::stop
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::stPlaybackTimer
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::updateTrackBlock
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrackBlock
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::serviceStop
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:00 volumio volumio[723]: info: ControllerMpd::stop
Oct 24 05:39:00 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::clearPlayQueue
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::saveQueue
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::volumioPushQueue
Oct 24 05:39:00 volumio volumio[723]: info: sendMpdCommand stop took 82 milliseconds
Oct 24 05:39:00 volumio volumio[723]: info:
Oct 24 05:39:00 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:00 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:00 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:00 volumio volumio[723]: info:
Oct 24 05:39:00 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:00 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:00 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:00 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:00 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:00 volumio volumio[723]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 24 05:39:00 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::syncState stateService stop
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:00 volumio volumio[723]: info: No code
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:00 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:00 volumio volumio[723]: error: updateQueue error: null
Oct 24 05:39:00 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:00 volumio volumio[723]: info: Starting UPNP Playback
Oct 24 05:39:00 volumio volumio[723]: info: Preparing playback through UPNP
Oct 24 05:39:00 volumio volumio[723]: info: CoreCommandRouter::volumioGetState
Oct 24 05:39:00 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:00 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:01 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:01 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:01 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:01 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:01 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:01 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:01 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:01 volumio volumio[723]: info: sendMpdCommand status took 17 milliseconds
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:01 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:01 volumio volumio[723]: info:
Oct 24 05:39:01 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:01 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:01 volumio volumio[723]: info: sendMpdCommand playlistinfo took 3 milliseconds
Oct 24 05:39:01 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:01 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:01 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:01 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":259,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"数码宝贝第一季主题曲《JLE架子鼓...(伴奏)_把我手累死了(网络歌手)","artist":"网络歌手","album":null,"uri":"http://lv.sycdn.kuwo.cn/7ce31e3185dd94b2474e4ca6ef682a49/67196cf4/resource/30106/trackmedia/M500004e3X1g02tm06.mp3","trackType":"mp3"}
Oct 24 05:39:01 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 25ms
Oct 24 05:39:01 volumio volumio[723]: info: sendMpdCommand status took 5 milliseconds
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 11ms
Oct 24 05:39:01 volumio volumio[723]: info: sendMpdCommand status took 11 milliseconds
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:01 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:39:01 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:01 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:01 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:01 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:01 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":259,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"数码宝贝第一季主题曲《JLE架子鼓...(伴奏)_把我手累死了(网络歌手)","artist":"网络歌手","album":null,"uri":"http://lv.sycdn.kuwo.cn/7ce31e3185dd94b2474e4ca6ef682a49/67196cf4/resource/30106/trackmedia/M500004e3X1g02tm06.mp3","trackType":"mp3"}
Oct 24 05:39:01 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:39:01 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:01 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:01 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:01 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":259,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"数码宝贝第一季主题曲《JLE架子鼓...(伴奏)_把我手累死了(网络歌手)","artist":"网络歌手","album":null,"uri":"http://lv.sycdn.kuwo.cn/7ce31e3185dd94b2474e4ca6ef682a49/67196cf4/resource/30106/trackmedia/M500004e3X1g02tm06.mp3","trackType":"mp3"}
Oct 24 05:39:01 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:39:01 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:01 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 45ms
Oct 24 05:39:01 volumio volumio[723]: info: ------------------------------ 45ms
Oct 24 05:39:10 volumio volumio[723]: info: Clearing queue after UPNP request
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::ClearQueue
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::stop
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::stPlaybackTimer
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::updateTrackBlock
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrackBlock
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::serviceStop
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:10 volumio volumio[723]: info: ControllerMpd::stop
Oct 24 05:39:10 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::clearPlayQueue
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::saveQueue
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::volumioPushQueue
Oct 24 05:39:10 volumio volumio[723]: info:
Oct 24 05:39:10 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:10 volumio volumio[723]: info: sendMpdCommand stop took 39 milliseconds
Oct 24 05:39:10 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:10 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:10 volumio volumio[723]: info:
Oct 24 05:39:10 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:10 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:10 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:10 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:10 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:10 volumio volumio[723]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 24 05:39:10 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::syncState stateService stop
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:10 volumio volumio[723]: info: No code
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:10 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:10 volumio volumio[723]: error: updateQueue error: null
Oct 24 05:39:10 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:10 volumio volumio[723]: info: Starting UPNP Playback
Oct 24 05:39:10 volumio volumio[723]: info: Preparing playback through UPNP
Oct 24 05:39:10 volumio volumio[723]: info: CoreCommandRouter::volumioGetState
Oct 24 05:39:10 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:10 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:11 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:11 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:11 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:11 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:11 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:11 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:11 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:11 volumio volumio[723]: info: sendMpdCommand status took 17 milliseconds
Oct 24 05:39:11 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:11 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:11 volumio volumio[723]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:11 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:11 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:11 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":155,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"手碟 / 箱鼓即兴演奏","artist":"黑夜跟白天 (Performer)","album":null,"uri":"http://lv.sycdn.kuwo.cn/5541fe17fe99ac1121618be5c0dfa2a5/67196cfe/resource/30106/trackmedia/M500001E65oQ0RLAw2.mp3","trackType":"mp3"}
Oct 24 05:39:11 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 27ms
Oct 24 05:39:11 volumio volumio[723]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:11 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:11 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:11 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":155,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"手碟 / 箱鼓即兴演奏","artist":"黑夜跟白天 (Performer)","album":null,"uri":"http://lv.sycdn.kuwo.cn/5541fe17fe99ac1121618be5c0dfa2a5/67196cfe/resource/30106/trackmedia/M500001E65oQ0RLAw2.mp3","trackType":"mp3"}
Oct 24 05:39:11 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:39:11 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 29ms
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:11 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:11 volumio volumio[723]: info:
Oct 24 05:39:11 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:11 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 6ms
Oct 24 05:39:11 volumio volumio[723]: info: sendMpdCommand status took 6 milliseconds
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:11 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:39:11 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:11 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:11 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:11 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":155,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"手碟&箱鼓即兴演奏","artist":"黑夜跟白天","album":"自然之音 (手碟)","uri":"http://lv.sycdn.kuwo.cn/5541fe17fe99ac1121618be5c0dfa2a5/67196cfe/resource/30106/trackmedia/M500001E65oQ0RLAw2.mp3","trackType":"mp3"}
Oct 24 05:39:11 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:39:11 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:11 volumio volumio[723]: info: ------------------------------ 18ms
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:11 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:39:11 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:11 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:11 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:39:32 volumio volumio[723]: info: Clearing queue after UPNP request
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::ClearQueue
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::stop
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::stPlaybackTimer
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::updateTrackBlock
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrackBlock
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::serviceStop
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:33 volumio volumio[723]: info: ControllerMpd::stop
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::clearPlayQueue
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::saveQueue
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushQueue
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:33 volumio volumio[723]: info: sendMpdCommand stop took 14 milliseconds
Oct 24 05:39:33 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:33 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:33 volumio volumio[723]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 24 05:39:33 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::syncState stateService stop
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:33 volumio volumio[723]: info: No code
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:33 volumio volumio[723]: error: updateQueue error: null
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:33 volumio volumio[723]: info: Starting UPNP Playback
Oct 24 05:39:33 volumio volumio[723]: info: Preparing playback through UPNP
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioGetState
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 2ms
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 2ms
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 2ms
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:33 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:33 volumio volumio[723]: info: sendMpdCommand status took 19 milliseconds
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:33 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:33 volumio volumio[723]: info:
Oct 24 05:39:33 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:33 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:33 volumio volumio[723]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 24 05:39:33 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:33 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:33 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:33 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":94,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ASMR手碟鼓:淨化","artist":"瑜珈精选音乐","album":"ASMR手碟鼓:治癒心靈、冥想沈靜、瑜珈音樂","uri":"http://lw.sycdn.kuwo.cn/20b6c6c37bed1008eb47402f05bc9b54/67196d14/resource/30106/trackmedia/M500003vc9QT4GpAZE.mp3","trackType":"mp3"}
Oct 24 05:39:33 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 25ms
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 3ms
Oct 24 05:39:33 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:39:33 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:33 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:33 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:33 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":94,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ASMR手碟鼓:淨化","artist":"瑜珈精选音乐","album":"ASMR手碟鼓:治癒心靈、冥想沈靜、瑜珈音樂","uri":"http://lw.sycdn.kuwo.cn/20b6c6c37bed1008eb47402f05bc9b54/67196d14/resource/30106/trackmedia/M500003vc9QT4GpAZE.mp3","trackType":"mp3"}
Oct 24 05:39:33 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:39:33 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:33 volumio volumio[723]: info: ------------------------------ 15ms
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:39:33 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:33 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:33 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:39:45 volumio volumio[723]: info: Clearing queue after UPNP request
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::ClearQueue
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::stop
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::stPlaybackTimer
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::updateTrackBlock
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrackBlock
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::serviceStop
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:45 volumio volumio[723]: info: ControllerMpd::stop
Oct 24 05:39:45 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::clearPlayQueue
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::saveQueue
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::volumioPushQueue
Oct 24 05:39:45 volumio volumio[723]: info: sendMpdCommand stop took 19 milliseconds
Oct 24 05:39:45 volumio volumio[723]: info:
Oct 24 05:39:45 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:45 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:45 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:45 volumio volumio[723]: info:
Oct 24 05:39:45 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:45 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:45 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:45 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:45 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:45 volumio volumio[723]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 24 05:39:45 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::syncState stateService stop
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:45 volumio volumio[723]: info: No code
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:45 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:45 volumio volumio[723]: error: updateQueue error: null
Oct 24 05:39:45 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:39:45 volumio volumio[723]: info: Starting UPNP Playback
Oct 24 05:39:45 volumio volumio[723]: info: Preparing playback through UPNP
Oct 24 05:39:45 volumio volumio[723]: info: CoreCommandRouter::volumioGetState
Oct 24 05:39:45 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:45 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 05:39:45 volumio volumio[723]: info:
Oct 24 05:39:45 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:45 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:46 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:46 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 0ms
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:46 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:46 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:46 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 0ms
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:46 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:46 volumio volumio[723]: info: sendMpdCommand status took 17 milliseconds
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:46 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:46 volumio volumio[723]: info:
Oct 24 05:39:46 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:46 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:46 volumio volumio[723]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 24 05:39:46 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:46 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:46 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:46 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":78,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ASMR手碟鼓:呼吸","artist":"瑜珈精选音乐","album":"ASMR手碟鼓:治癒心靈、冥想沈靜、瑜珈音樂","uri":"http://lw.sycdn.kuwo.cn/e7e3d45a0fb4fa99a7b5b7fcec2e45b5/67196d21/resource/30106/trackmedia/M500003wjrak4KeZvB.mp3","trackType":"mp3"}
Oct 24 05:39:46 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 21ms
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 2ms
Oct 24 05:39:46 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:39:46 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:46 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:46 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:46 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":78,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ASMR手碟鼓:呼吸","artist":"瑜珈精选音乐","album":"ASMR手碟鼓:治癒心靈、冥想沈靜、瑜珈音樂","uri":"http://lw.sycdn.kuwo.cn/e7e3d45a0fb4fa99a7b5b7fcec2e45b5/67196d21/resource/30106/trackmedia/M500003wjrak4KeZvB.mp3","trackType":"mp3"}
Oct 24 05:39:46 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:39:46 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:46 volumio volumio[723]: info: ------------------------------ 12ms
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:46 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:39:46 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:46 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:46 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:39:51 volumio volumio[723]: info: Clearing queue after UPNP request
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::ClearQueue
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::stop
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::stPlaybackTimer
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::updateTrackBlock
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrackBlock
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::serviceStop
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:52 volumio volumio[723]: info: ControllerMpd::stop
Oct 24 05:39:52 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::clearPlayQueue
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::saveQueue
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::volumioPushQueue
Oct 24 05:39:52 volumio volumio[723]: info: sendMpdCommand stop took 69 milliseconds
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:52 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:52 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:52 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:52 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:39:52 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:52 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:52 volumio volumio[723]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 24 05:39:52 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::syncState stateService stop
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:52 volumio volumio[723]: info: No code
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 23ms
Oct 24 05:39:52 volumio volumio[723]: error: updateQueue error: null
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 23ms
Oct 24 05:39:52 volumio volumio[723]: info: Starting UPNP Playback
Oct 24 05:39:52 volumio volumio[723]: info: Preparing playback through UPNP
Oct 24 05:39:52 volumio volumio[723]: info: CoreCommandRouter::volumioGetState
Oct 24 05:39:52 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:39:52 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:52 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 2ms
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:52 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 2ms
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:52 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:52 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:52 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:52 volumio volumio[723]: info:
Oct 24 05:39:52 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:52 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:52 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:39:53 volumio volumio[723]: info:
Oct 24 05:39:53 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:53 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:53 volumio volumio[723]: info:
Oct 24 05:39:53 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:39:53 volumio volumio[723]: info: sendMpdCommand status took 15 milliseconds
Oct 24 05:39:53 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:53 volumio volumio[723]: info:
Oct 24 05:39:53 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:39:53 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:39:53 volumio volumio[723]: info: sendMpdCommand status took 2 milliseconds
Oct 24 05:39:53 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:53 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:53 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:53 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":76,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ASMR手碟鼓:啟發","artist":"瑜珈精选音乐","album":"ASMR手碟鼓:治癒心靈、冥想沈靜、瑜珈音樂","uri":"http://lw.sycdn.kuwo.cn/2697c8fb0e7d326fbbf6f884f0579cad/67196d27/resource/30106/trackmedia/M500001taEBi2qeM2h.mp3","trackType":"mp3"}
Oct 24 05:39:53 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:39:53 volumio volumio[723]: info: ------------------------------ 19ms
Oct 24 05:39:53 volumio volumio[723]: info: ------------------------------ 3ms
Oct 24 05:39:53 volumio volumio[723]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 24 05:39:53 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:39:53 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:39:53 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:39:53 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":377,"duration":76,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ASMR手碟鼓:啟發","artist":"瑜珈精选音乐","album":"ASMR手碟鼓:治癒心靈、冥想沈靜、瑜珈音樂","uri":"http://lw.sycdn.kuwo.cn/2697c8fb0e7d326fbbf6f884f0579cad/67196d27/resource/30106/trackmedia/M500001taEBi2qeM2h.mp3","trackType":"mp3"}
Oct 24 05:39:53 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:39:53 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:39:53 volumio volumio[723]: info: ------------------------------ 12ms
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:53 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:39:53 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:39:53 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:39:53 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:40:16 volumio volumio[723]: info: Clearing queue after UPNP request
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::ClearQueue
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::stop
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::stPlaybackTimer
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::updateTrackBlock
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrackBlock
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::serviceStop
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:16 volumio volumio[723]: info: ControllerMpd::stop
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::clearPlayQueue
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::saveQueue
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushQueue
Oct 24 05:40:16 volumio volumio[723]: info: sendMpdCommand stop took 17 milliseconds
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:40:16 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:40:16 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:16 volumio volumio[723]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 24 05:40:16 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::syncState stateService stop
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:16 volumio volumio[723]: info: No code
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:40:16 volumio volumio[723]: error: updateQueue error: null
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:40:16 volumio volumio[723]: info: Starting UPNP Playback
Oct 24 05:40:16 volumio volumio[723]: info: Preparing playback through UPNP
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioGetState
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 2ms
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:40:16 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:40:16 volumio volumio[723]: info: sendMpdCommand status took 15 milliseconds
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:40:16 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:40:16 volumio volumio[723]: info:
Oct 24 05:40:16 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:16 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:16 volumio volumio[723]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 24 05:40:16 volumio volumio[723]: info: sendMpdCommand status took 2 milliseconds
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:40:16 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:40:16 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:40:16 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":155,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"手碟&箱鼓即兴演奏","artist":"黑夜跟白天","album":"自然之音 (手碟)","uri":"http://lv.sycdn.kuwo.cn/91324632798d81e2853cb85f9381263a/67196d3f/resource/30106/trackmedia/M500001E65oQ0RLAw2.mp3","trackType":"mp3"}
Oct 24 05:40:16 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 21ms
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 4ms
Oct 24 05:40:16 volumio volumio[723]: info: sendMpdCommand playlistinfo took 2 milliseconds
Oct 24 05:40:16 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:40:16 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:40:16 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:40:16 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":480,"duration":155,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"手碟&箱鼓即兴演奏","artist":"黑夜跟白天","album":"自然之音 (手碟)","uri":"http://lv.sycdn.kuwo.cn/91324632798d81e2853cb85f9381263a/67196d3f/resource/30106/trackmedia/M500001E65oQ0RLAw2.mp3","trackType":"mp3"}
Oct 24 05:40:16 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:40:16 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:16 volumio volumio[723]: info: ------------------------------ 17ms
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:40:16 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:40:16 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:40:16 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:40:27 volumio volumio[723]: info: Clearing queue after UPNP request
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::ClearQueue
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::stop
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService undefined
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::stPlaybackTimer
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::updateTrackBlock
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrackBlock
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::serviceStop
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::stop
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand stop
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::clearPlayQueue
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::saveQueue
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushQueue
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:40:28 volumio volumio[723]: info: sendMpdCommand stop took 87 milliseconds
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:28 volumio volumio[723]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Oct 24 05:40:28 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::syncState stateService stop
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:28 volumio volumio[723]: info: No code
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 13ms
Oct 24 05:40:28 volumio volumio[723]: error: updateQueue error: null
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 12ms
Oct 24 05:40:28 volumio volumio[723]: info: Starting UPNP Playback
Oct 24 05:40:28 volumio volumio[723]: info: Preparing playback through UPNP
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioGetState
Oct 24 05:40:28 volumio volumio[723]: info: CorePlayQueue::getTrack 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::setConsumeUpdateService mpd
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 1ms
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:40:28 volumio volumio[723]: info: sendMpdCommand status took 18 milliseconds
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:40:28 volumio volumio[723]: info: sendMpdCommand status took 1 milliseconds
Oct 24 05:40:28 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:40:28 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:40:28 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":78,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ASMR手碟鼓:呼吸","artist":"艾米希瑜珈之音/Yoga Featured Music/เพลงโยคะ (Performer)","album":null,"uri":"http://lw.sycdn.kuwo.cn/058ab76d88da04b11e63e88c8aeb2c72/67196d4b/resource/30106/trackmedia/M500003wjrak4KeZvB.mp3","trackType":"mp3"}
Oct 24 05:40:28 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus stop
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 22ms
Oct 24 05:40:28 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:40:28 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:40:28 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":78,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"ASMR手碟鼓:呼吸","artist":"艾米希瑜珈之音/Yoga Featured Music/เพลงโยคะ (Performer)","album":null,"uri":"http://lw.sycdn.kuwo.cn/058ab76d88da04b11e63e88c8aeb2c72/67196d4b/resource/30106/trackmedia/M500003wjrak4KeZvB.mp3","trackType":"mp3"}
Oct 24 05:40:28 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:40:28 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:28 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:28 volumio volumio[723]: info: ------------------------------ 15ms
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces system playlist update
Oct 24 05:40:28 volumio volumio[723]: info: Ignoring MPD Status Update
Oct 24 05:40:28 volumio volumio[723]: info:
Oct 24 05:40:28 volumio volumio[723]: ---------------------------- MPD announces state update: player
Oct 24 05:40:28 volumio volumio[723]: info: ControllerMpd::getState
Oct 24 05:40:28 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand status
Oct 24 05:40:29 volumio volumio[723]: info: ------------------------------ 10ms
Oct 24 05:40:29 volumio volumio[723]: info: sendMpdCommand status took 9 milliseconds
Oct 24 05:40:29 volumio volumio[723]: verbose: ControllerMpd::parseState
Oct 24 05:40:29 volumio volumio[723]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Oct 24 05:40:29 volumio volumio[723]: info: sendMpdCommand playlistinfo took 1 milliseconds
Oct 24 05:40:29 volumio volumio[723]: verbose: ControllerMpd::parseTrackInfo
Oct 24 05:40:29 volumio volumio[723]: info: ControllerMpd::pushState
Oct 24 05:40:29 volumio volumio[723]: info: CoreCommandRouter::servicePushState
Oct 24 05:40:29 volumio volumio[723]: verbose: In UPNP mode
Oct 24 05:40:29 volumio volumio[723]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":78,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ASMR手碟鼓:呼吸","artist":"瑜珈精选音乐","album":"ASMR手碟鼓:治癒心靈、冥想沈靜、瑜珈音樂","uri":"http://lw.sycdn.kuwo.cn/058ab76d88da04b11e63e88c8aeb2c72/67196d4b/resource/30106/trackmedia/M500003wjrak4KeZvB.mp3","trackType":"mp3"}
Oct 24 05:40:29 volumio volumio[723]: verbose: CURRENT POSITION 0
Oct 24 05:40:29 volumio volumio[723]: info: CoreStateMachine::syncState stateService play
Oct 24 05:40:29 volumio volumio[723]: info: CoreStateMachine::syncState currentStatus play
Oct 24 05:40:29 volumio volumio[723]: info: Received an update from plugin. extracting info from payload
Oct 24 05:40:29 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Oct 24 05:40:29 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:29 volumio volumio[723]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Oct 24 05:40:29 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:29 volumio volumio[723]: info: CoreStateMachine::pushState
Oct 24 05:40:29 volumio volumio[723]: info: CoreCommandRouter::volumioPushState
Oct 24 05:40:29 volumio volumio[723]: info: ------------------------------ 23ms
Oct 24 05:40:29 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:40:29 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:40:29 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:40:29 volumio volumio[723]: info: CoreCommandRouter::volumioGetQueue
Oct 24 05:40:29 volumio volumio[723]: info: CoreStateMachine::getQueue
Oct 24 05:40:29 volumio volumio[723]: info: CorePlayQueue::getQueue
Oct 24 05:40:33 volumio volumio[723]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 24 05:40:33 volumio volumio[723]: Error: connect ETIMEDOUT 174.37.175.229:80
Oct 24 05:40:33 volumio volumio[723]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) {
Oct 24 05:40:33 volumio volumio[723]: errno: -110,
Oct 24 05:40:33 volumio volumio[723]: code: 'ETIMEDOUT',
Oct 24 05:40:33 volumio volumio[723]: syscall: 'connect',
Oct 24 05:40:33 volumio volumio[723]: address: '174.37.175.229',
Oct 24 05:40:33 volumio volumio[723]: port: 80
Oct 24 05:40:33 volumio volumio[723]: }
Oct 24 05:40:33 volumio volumio[723]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Oct 24 05:40:33 volumio sudo[6986]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-24 05:39
Oct 24 05:40:33 volumio sudo[6986]: 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="cd8cf34b47ce852e70b71e6f7b6e0265f7fdb695"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="8f88153f9a18f312d56050e6613b45a852ac819a"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 27 Sep 2023 11:35:49 AM CEST"
VOLUMIO_VERSION="3.546"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="6823c0d83061ff736b7e0dd4481bc496"