-- Logs begin at Thu 2025-10-16 04:13:21 HKT, end at Thu 2025-10-16 04:16:22 HKT. -- Oct 16 04:15:00 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:00 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:15:00 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand stop took 1 milliseconds Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand clear took 1 milliseconds Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3" Oct 16 04:15:00 volumio volumio[1125]: info: Oct 16 04:15:00 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:00 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:00 volumio volumio[1125]: info: Oct 16 04:15:00 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:00 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3" took 1 milliseconds Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:15:00 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:15:00 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:15:00 volumio volumio[1125]: error: Upnp client error: Error: This socket has been ended by the other party Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand play took 2 milliseconds Oct 16 04:15:00 volumio volumio[1125]: info: Oct 16 04:15:00 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:00 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand status took 38 milliseconds Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:00 volumio volumio[1125]: info: Oct 16 04:15:00 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:00 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:00 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:00 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:00 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:00 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Footprints In The Sand","artist":"萱萱","album":"中国好声音第二季 巅峰之夜","uri":"USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3","trackType":"mp3"} Oct 16 04:15:00 volumio volumio[1125]: verbose: CURRENT POSITION 0 Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:15:00 volumio volumio[1125]: info: ------------------------------ 43ms Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand status took 4 milliseconds Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:00 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 16 04:15:00 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:00 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:00 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:00 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:00 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":241,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Footprints In The Sand","artist":"萱萱","album":"中国好声音第二季 巅峰之夜","uri":"USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3","trackType":"mp3"} Oct 16 04:15:00 volumio volumio[1125]: verbose: CURRENT POSITION 0 Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:15:00 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:00 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:00 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:00 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:00 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:00 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:00 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:00 volumio volumio[1125]: info: ------------------------------ 15ms Oct 16 04:15:03 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:03 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:03 volumio sudo[2344]: root : TTY=unknown ; PWD=/data/plugins/user_interface/peppy_screensaver ; USER=root ; COMMAND=/bin/bash run_peppymeter.sh Oct 16 04:15:03 volumio sudo[2344]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 16 04:15:03 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 8 Oct 16 04:15:03 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:03 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:04 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:15:04 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:06 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 04:15:06 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 04:15:13 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:15 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:15:15 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:15 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand stop took 18 milliseconds Oct 16 04:15:15 volumio volumio[1125]: info: Oct 16 04:15:15 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E8%90%B1%E8%90%B1/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E5%B7%85%E5%B3%B0%E4%B9%8B%E5%A4%9C/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Ffootprints%20in%20the%20sand%20-%20%E8%90%B1%E8%90%B1.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E5%BC%A0%E6%83%A0%E5%A6%B9%2C%E6%9D%8E%E7%90%A6%2C%E5%A1%94%E6%96%AF%E8%82%AF%2C%E5%88%98%E9%9B%85%E5%A9%B7%2C%E7%8E%8B%E6%8B%93/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E5%BC%A0%E6%83%A0%E5%A6%B9%E7%BB%84%E5%9B%9B%E8%BF%9B%E4%B8%80/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fare%20you%20ready%20-%20%E5%BC%A0%E6%83%A0%E5%A6%B9%2C%E6%9D%8E%E7%90%A6%2C%E5%A1%94%E6%96%AF%E8%82%AF%2C%E5%88%98%E9%9B%85%E5%A9%B7%2C%E7%8E%8B%E6%8B%93.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E9%92%9F%E4%BC%9F%E5%BC%BA%2C%E6%AF%95%E5%A4%8F/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E6%B1%AA%E5%B3%B0%E7%BB%84PK/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fhey%20jude%20-%20%E9%92%9F%E4%BC%9F%E5%BC%BA%2C%E6%AF%95%E5%A4%8F.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::play index 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:15 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: Exploding uri music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 in service mpd Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E4%B8%81%E5%85%8B%E6%A3%AE/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%AC%AC1%E6%9C%9F/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fbad%20boy%20-%20%E4%B8%81%E5%85%8B%E6%A3%AE.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E5%BC%A0%E6%96%B0/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%AC%AC3%E6%9C%9F/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Ffalling%20-%20%E5%BC%A0%E6%96%B0.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E5%B8%B8%E9%A2%96/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%AC%AC3%E6%9C%9F/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Ffunky%20music%20-%20%E5%B8%B8%E9%A2%96.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E5%91%A8%E8%AF%97%E9%A2%96/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%AC%AC4%E6%9C%9F/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fbad%20boy%20-%20%E5%91%A8%E8%AF%97%E9%A2%96.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E9%9D%9E%E9%9D%9E/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%AC%AC4%E6%9C%9F/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fcome%20together%20-%20%E9%9D%9E%E9%9D%9E.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E7%8E%8B%E6%B4%AA%E8%BF%AA/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%BB%88%E6%9E%81%E8%80%83%E6%A0%B8/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2F3-7-20-1%20-%20%E7%8E%8B%E6%B4%AA%E8%BF%AA.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E5%A1%94%E6%96%AF%E8%82%AF/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%BB%88%E6%9E%81%E8%80%83%E6%A0%B8/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fangel%20-%20%E5%A1%94%E6%96%AF%E8%82%AF.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E8%90%B1%E8%90%B1/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E7%BB%88%E6%9E%81%E8%80%83%E6%A0%B8/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fbleeding%20love%20-%20%E8%90%B1%E8%90%B1.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E7%94%B0%E5%9B%AD%2C%E5%94%90%E8%8D%AD%E8%8F%B2/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E9%82%A3%E8%8B%B1%E7%BB%84PK/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fevery%20breath%20you%20take%20-%20%E7%94%B0%E5%9B%AD%2C%E5%94%90%E8%8D%AD%E8%8F%B2.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E5%A7%9A%E8%B4%9D%E5%A8%9C/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E9%82%A3%E8%8B%B1%E7%BB%84%E5%9B%9B%E8%BF%9B%E4%B8%80/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fall%20by%20myself%20-%20%E5%A7%9A%E8%B4%9D%E5%A8%9C.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: ALBUMART /albumart?cacheid=645&web=%E5%A7%9A%E8%B4%9D%E5%A8%9C/%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%E7%AC%AC%E4%BA%8C%E5%AD%A3%20%E9%82%A3%E8%8B%B1%E7%BB%84%E5%9B%9B%E8%BF%9B%E4%B8%80/extralarge&path=%2Fmnt%2FUSB%2FD48E-B049%2F%E4%B8%AD%E5%9B%BD%E5%A5%BD%E5%A3%B0%E9%9F%B3%2Fdear%20friend%20-%20%E5%A7%9A%E8%B4%9D%E5%A8%9C.mp3&metadata=false Oct 16 04:15:15 volumio volumio[1125]: info: URI /mnt/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand status took 13 milliseconds Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand stop took 3 milliseconds Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:15 volumio volumio[1125]: info: Oct 16 04:15:15 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:15 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand clear took 7 milliseconds Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3" Oct 16 04:15:15 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Footprints In The Sand","artist":"萱萱","album":"中国好声音第二季 巅峰之夜","uri":"USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3","trackType":"mp3"} Oct 16 04:15:15 volumio volumio[1125]: verbose: CURRENT POSITION 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::syncState stateService stop Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:15 volumio volumio[1125]: info: No code Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:15 volumio volumio[1125]: info: ------------------------------ 38ms Oct 16 04:15:15 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:15:15 volumio volumio[1125]: info: Oct 16 04:15:15 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:15 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:15 volumio volumio[1125]: info: ------------------------------ 19ms Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3" took 19 milliseconds Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:15:15 volumio volumio[1125]: info: ------------------------------ 10ms Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand play took 9 milliseconds Oct 16 04:15:15 volumio volumio[1125]: info: Oct 16 04:15:15 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:15 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:15 volumio volumio[1125]: info: Oct 16 04:15:15 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand status took 2 milliseconds Oct 16 04:15:15 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:15 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hey Jude","artist":"钟伟强,毕夏","album":"中国好声音第二季 汪峰组PK","uri":"USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3","trackType":"mp3"} Oct 16 04:15:15 volumio volumio[1125]: verbose: CURRENT POSITION 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:15:15 volumio volumio[1125]: info: ------------------------------ 6ms Oct 16 04:15:15 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 04:15:15 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:15 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hey Jude","artist":"钟伟强,毕夏","album":"中国好声音第二季 汪峰组PK","uri":"USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3","trackType":"mp3"} Oct 16 04:15:15 volumio volumio[1125]: verbose: CURRENT POSITION 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:15:15 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:15 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:15 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:15 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:15 volumio volumio[1125]: info: ------------------------------ 15ms Oct 16 04:15:18 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:15:18 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:18 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:22 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:15:22 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:22 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::play index 3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:22 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:22 volumio volumio[1125]: info: Oct 16 04:15:22 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand stop took 21 milliseconds Oct 16 04:15:22 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand stop took 3 milliseconds Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:15:22 volumio volumio[1125]: info: Oct 16 04:15:22 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:22 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand clear took 1 milliseconds Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3" Oct 16 04:15:22 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:15:22 volumio volumio[1125]: info: Oct 16 04:15:22 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:22 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:22 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3" took 1 milliseconds Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:15:22 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:15:22 volumio volumio[1125]: info: ------------------------------ 4ms Oct 16 04:15:22 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand play took 1 milliseconds Oct 16 04:15:22 volumio volumio[1125]: info: Oct 16 04:15:22 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:22 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:22 volumio volumio[1125]: info: Oct 16 04:15:22 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand status took 2 milliseconds Oct 16 04:15:22 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:22 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:22 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":148,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"丁克森","album":"中国好声音第二季 第1期","uri":"USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3","trackType":"mp3"} Oct 16 04:15:22 volumio volumio[1125]: verbose: CURRENT POSITION 3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:15:22 volumio volumio[1125]: info: ------------------------------ 4ms Oct 16 04:15:22 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 04:15:22 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:22 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:22 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":148,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"丁克森","album":"中国好声音第二季 第1期","uri":"USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3","trackType":"mp3"} Oct 16 04:15:22 volumio volumio[1125]: verbose: CURRENT POSITION 3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:15:22 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:22 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:22 volumio volumio[1125]: info: ------------------------------ 15ms Oct 16 04:15:25 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:15:25 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:25 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:33 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:15:33 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:33 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::play index 0 Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:33 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:33 volumio volumio[1125]: info: Oct 16 04:15:33 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand stop took 19 milliseconds Oct 16 04:15:33 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand stop took 2 milliseconds Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:15:33 volumio volumio[1125]: info: Oct 16 04:15:33 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:33 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand clear took 0 milliseconds Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3" Oct 16 04:15:33 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:15:33 volumio volumio[1125]: info: Oct 16 04:15:33 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:33 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:33 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3" took 1 milliseconds Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:15:33 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:15:33 volumio volumio[1125]: info: ------------------------------ 4ms Oct 16 04:15:33 volumio volumio[1125]: info: ------------------------------ 1ms Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand play took 2 milliseconds Oct 16 04:15:33 volumio volumio[1125]: info: Oct 16 04:15:33 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:33 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:33 volumio volumio[1125]: info: Oct 16 04:15:33 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand status took 4 milliseconds Oct 16 04:15:33 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:33 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:33 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Footprints In The Sand","artist":"萱萱","album":"中国好声音第二季 巅峰之夜","uri":"USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3","trackType":"mp3"} Oct 16 04:15:33 volumio volumio[1125]: verbose: CURRENT POSITION 0 Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:15:33 volumio volumio[1125]: info: ------------------------------ 6ms Oct 16 04:15:33 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:33 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:33 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:33 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":241,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Footprints In The Sand","artist":"萱萱","album":"中国好声音第二季 巅峰之夜","uri":"USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3","trackType":"mp3"} Oct 16 04:15:33 volumio volumio[1125]: verbose: CURRENT POSITION 0 Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:15:33 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:33 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:33 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:33 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:33 volumio volumio[1125]: info: ------------------------------ 15ms Oct 16 04:15:36 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:15:36 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:36 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:37 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 0 Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:15:37 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:37 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::play index 6 Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:15:37 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:15:37 volumio volumio[1125]: info: Oct 16 04:15:37 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand stop took 24 milliseconds Oct 16 04:15:37 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand stop took 7 milliseconds Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:15:37 volumio volumio[1125]: info: Oct 16 04:15:37 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:37 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand clear took 1 milliseconds Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3" Oct 16 04:15:37 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:15:37 volumio volumio[1125]: info: Oct 16 04:15:37 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:15:37 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:15:37 volumio volumio[1125]: info: ------------------------------ 1ms Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3" took 1 milliseconds Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:15:37 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:15:37 volumio volumio[1125]: info: ------------------------------ 3ms Oct 16 04:15:37 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand play took 1 milliseconds Oct 16 04:15:37 volumio volumio[1125]: info: Oct 16 04:15:37 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:37 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:37 volumio volumio[1125]: info: Oct 16 04:15:37 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand status took 3 milliseconds Oct 16 04:15:37 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand status took 0 milliseconds Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:37 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:37 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":162,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"周诗颖","album":"中国好声音第二季 第4期","uri":"USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3","trackType":"mp3"} Oct 16 04:15:37 volumio volumio[1125]: verbose: CURRENT POSITION 6 Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:15:37 volumio volumio[1125]: info: ------------------------------ 5ms Oct 16 04:15:37 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:15:37 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:15:37 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:37 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":162,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"周诗颖","album":"中国好声音第二季 第4期","uri":"USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3","trackType":"mp3"} Oct 16 04:15:37 volumio volumio[1125]: verbose: CURRENT POSITION 6 Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:15:37 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:37 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:15:37 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:37 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:15:37 volumio volumio[1125]: info: ------------------------------ 14ms Oct 16 04:15:40 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:15:40 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:40 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:41 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:41 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:15:44 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 16 04:15:44 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 16 04:15:46 volumio volumio[1125]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 16 04:15:46 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 04:15:51 volumio volumio[1125]: info: CALLMETHOD: user_interface peppy_screensaver saveVUMeterConf [object Object] Oct 16 04:15:51 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , saveVUMeterConf Oct 16 04:15:52 volumio volumio[1125]: info: CALLMETHOD: user_interface peppy_screensaver savePeppyMeterConf [object Object] Oct 16 04:15:52 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: peppy_screensaver , savePeppyMeterConf Oct 16 04:15:52 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 04:15:52 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 04:15:52 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 04:15:52 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 16 04:15:55 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:15:55 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:04 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:16:04 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:04 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::play index 2 Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:04 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:04 volumio volumio[1125]: info: Oct 16 04:16:04 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand stop took 18 milliseconds Oct 16 04:16:04 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand stop took 2 milliseconds Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:16:04 volumio volumio[1125]: info: Oct 16 04:16:04 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:04 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand clear took 1 milliseconds Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3" Oct 16 04:16:04 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:16:04 volumio volumio[1125]: info: Oct 16 04:16:04 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:04 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:04 volumio volumio[1125]: info: ------------------------------ 1ms Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3" took 2 milliseconds Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:16:04 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:16:04 volumio volumio[1125]: info: ------------------------------ 3ms Oct 16 04:16:04 volumio volumio[1125]: info: Oct 16 04:16:04 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:04 volumio volumio[1125]: info: ------------------------------ 6ms Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand play took 5 milliseconds Oct 16 04:16:04 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:04 volumio volumio[1125]: info: Oct 16 04:16:04 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:04 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand status took 4 milliseconds Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand status took 2 milliseconds Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:04 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:04 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hey Jude","artist":"钟伟强,毕夏","album":"中国好声音第二季 汪峰组PK","uri":"USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3","trackType":"mp3"} Oct 16 04:16:04 volumio volumio[1125]: verbose: CURRENT POSITION 2 Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:16:04 volumio volumio[1125]: info: ------------------------------ 8ms Oct 16 04:16:04 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 04:16:04 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:04 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:04 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":125,"duration":233,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Hey Jude","artist":"钟伟强,毕夏","album":"中国好声音第二季 汪峰组PK","uri":"USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3","trackType":"mp3"} Oct 16 04:16:04 volumio volumio[1125]: verbose: CURRENT POSITION 2 Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:16:04 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:04 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:04 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:04 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:04 volumio volumio[1125]: info: ------------------------------ 22ms Oct 16 04:16:06 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 2 Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:16:06 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:06 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::play index 8 Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:06 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:06 volumio volumio[1125]: info: Oct 16 04:16:06 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand stop took 17 milliseconds Oct 16 04:16:06 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand stop took 4 milliseconds Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:16:06 volumio volumio[1125]: info: Oct 16 04:16:06 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:06 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand status took 0 milliseconds Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand clear took 0 milliseconds Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3" Oct 16 04:16:06 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:16:06 volumio volumio[1125]: info: Oct 16 04:16:06 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:06 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:06 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3" took 1 milliseconds Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:16:06 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:16:06 volumio volumio[1125]: info: ------------------------------ 4ms Oct 16 04:16:06 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand play took 2 milliseconds Oct 16 04:16:06 volumio volumio[1125]: info: Oct 16 04:16:06 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:06 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:06 volumio volumio[1125]: info: Oct 16 04:16:06 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand status took 2 milliseconds Oct 16 04:16:06 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand status took 0 milliseconds Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:06 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:06 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":114,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3-7-20-1","artist":"王洪迪","album":"中国好声音第二季 终极考核","uri":"USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3","trackType":"mp3"} Oct 16 04:16:06 volumio volumio[1125]: verbose: CURRENT POSITION 8 Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:16:06 volumio volumio[1125]: info: ------------------------------ 4ms Oct 16 04:16:06 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:06 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:06 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:06 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":114,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"3-7-20-1","artist":"王洪迪","album":"中国好声音第二季 终极考核","uri":"USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3","trackType":"mp3"} Oct 16 04:16:06 volumio volumio[1125]: verbose: CURRENT POSITION 8 Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:16:06 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:06 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:06 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:06 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:06 volumio volumio[1125]: info: ------------------------------ 14ms Oct 16 04:16:08 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:16:08 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:16:08 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:09 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 8 Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:16:09 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:09 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::play index 7 Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:09 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:09 volumio volumio[1125]: info: Oct 16 04:16:09 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand stop took 17 milliseconds Oct 16 04:16:09 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand stop took 2 milliseconds Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:16:09 volumio volumio[1125]: info: Oct 16 04:16:09 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:09 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand clear took 1 milliseconds Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/come together - 非非.mp3" Oct 16 04:16:09 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:16:09 volumio volumio[1125]: info: Oct 16 04:16:09 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:09 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:09 volumio volumio[1125]: info: ------------------------------ 1ms Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/come together - 非非.mp3" took 2 milliseconds Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:16:09 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:16:09 volumio volumio[1125]: info: ------------------------------ 3ms Oct 16 04:16:09 volumio volumio[1125]: info: ------------------------------ 1ms Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand play took 1 milliseconds Oct 16 04:16:09 volumio volumio[1125]: info: Oct 16 04:16:09 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:09 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:09 volumio volumio[1125]: info: Oct 16 04:16:09 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:16:09 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand status took 0 milliseconds Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:09 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:09 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":157,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come Together","artist":"非非","album":"中国好声音第二季 第4期","uri":"USB/D48E-B049/中国好声音/come together - 非非.mp3","trackType":"mp3"} Oct 16 04:16:09 volumio volumio[1125]: verbose: CURRENT POSITION 7 Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:16:09 volumio volumio[1125]: info: ------------------------------ 4ms Oct 16 04:16:09 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 04:16:09 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:09 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:09 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":157,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Come Together","artist":"非非","album":"中国好声音第二季 第4期","uri":"USB/D48E-B049/中国好声音/come together - 非非.mp3","trackType":"mp3"} Oct 16 04:16:09 volumio volumio[1125]: verbose: CURRENT POSITION 7 Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:16:09 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:09 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:09 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:09 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:09 volumio volumio[1125]: info: ------------------------------ 17ms Oct 16 04:16:10 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:16:10 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:16:10 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:11 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 7 Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:16:11 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:11 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::play index 6 Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:11 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:11 volumio volumio[1125]: info: Oct 16 04:16:11 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand stop took 22 milliseconds Oct 16 04:16:11 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand stop took 10 milliseconds Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand status took 2 milliseconds Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:11 volumio volumio[1125]: info: Oct 16 04:16:11 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:11 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand clear took 1 milliseconds Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3" Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:11 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:16:11 volumio volumio[1125]: info: ------------------------------ 3ms Oct 16 04:16:11 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:16:11 volumio volumio[1125]: info: Oct 16 04:16:11 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:11 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:11 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3" took 1 milliseconds Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:16:11 volumio volumio[1125]: info: ------------------------------ 1ms Oct 16 04:16:11 volumio volumio[1125]: info: Oct 16 04:16:11 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand play took 1 milliseconds Oct 16 04:16:11 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:11 volumio volumio[1125]: info: Oct 16 04:16:11 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand status took 3 milliseconds Oct 16 04:16:11 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:11 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:11 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:11 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:11 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":162,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"周诗颖","album":"中国好声音第二季 第4期","uri":"USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3","trackType":"mp3"} Oct 16 04:16:11 volumio volumio[1125]: verbose: CURRENT POSITION 6 Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:16:11 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:11 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":162,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"周诗颖","album":"中国好声音第二季 第4期","uri":"USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3","trackType":"mp3"} Oct 16 04:16:11 volumio volumio[1125]: verbose: CURRENT POSITION 6 Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:16:11 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:11 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:11 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:11 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:11 volumio volumio[1125]: info: ------------------------------ 9ms Oct 16 04:16:11 volumio volumio[1125]: info: ------------------------------ 11ms Oct 16 04:16:13 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::ClearQueue Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::serviceStop Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 6 Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::serviceStop Oct 16 04:16:13 volumio volumio[1125]: info: ControllerMpd::stop Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::clearPlayQueue Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:13 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/footprints in the sand - 萱萱.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/are you ready - 张惠妹,李琦,塔斯肯,刘雅婷,王拓.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/hey jude - 钟伟强,毕夏.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioPlay Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::play index 3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::addQueueItems Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::addQueueItems Oct 16 04:16:13 volumio volumio[1125]: info: Preload queue cleared Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/falling - 张新.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/funky music - 常颖.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bad boy - 周诗颖.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/come together - 非非.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/3-7-20-1 - 王洪迪.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/angel - 塔斯肯.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/bleeding love - 萱萱.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/every breath you take - 田园,唐荭菲.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/all by myself - 姚贝娜.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Adding Item to queue: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: Using cached record of: music-library/USB/D48E-B049/中国好声音/dear friend - 姚贝娜.mp3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::stop Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioPushQueue Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::saveQueue Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::play index undefined Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::updateTrackBlock Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrackBlock Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::startPlaybackTimer Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::clearAddPlayTracks USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3 Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand stop Oct 16 04:16:13 volumio volumio[1125]: info: Oct 16 04:16:13 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand stop took 15 milliseconds Oct 16 04:16:13 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand stop took 4 milliseconds Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand clear Oct 16 04:16:13 volumio volumio[1125]: info: Oct 16 04:16:13 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:13 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand status took 1 milliseconds Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand clear took 1 milliseconds Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3" Oct 16 04:16:13 volumio volumio[1125]: error: updateQueue error: null Oct 16 04:16:13 volumio volumio[1125]: info: Oct 16 04:16:13 volumio volumio[1125]: ---------------------------- MPD announces system playlist update Oct 16 04:16:13 volumio volumio[1125]: info: Ignoring MPD Status Update Oct 16 04:16:13 volumio volumio[1125]: info: ------------------------------ 2ms Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand add "USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3" took 1 milliseconds Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand play Oct 16 04:16:13 volumio volumio[1125]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 16 04:16:13 volumio volumio[1125]: info: ------------------------------ 3ms Oct 16 04:16:13 volumio volumio[1125]: info: Oct 16 04:16:13 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:13 volumio volumio[1125]: info: ------------------------------ 1ms Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand play took 2 milliseconds Oct 16 04:16:13 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:13 volumio volumio[1125]: info: Oct 16 04:16:13 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand status took 3 milliseconds Oct 16 04:16:13 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand status took 2 milliseconds Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:13 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:13 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":148,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"丁克森","album":"中国好声音第二季 第1期","uri":"USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3","trackType":"mp3"} Oct 16 04:16:13 volumio volumio[1125]: verbose: CURRENT POSITION 3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus stop Oct 16 04:16:13 volumio volumio[1125]: info: ------------------------------ 8ms Oct 16 04:16:13 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 16 04:16:13 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:13 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:13 volumio volumio[1125]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":148,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Bad Boy","artist":"丁克森","album":"中国好声音第二季 第1期","uri":"USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3","trackType":"mp3"} Oct 16 04:16:13 volumio volumio[1125]: verbose: CURRENT POSITION 3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::syncState stateService play Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus play Oct 16 04:16:13 volumio volumio[1125]: info: Received an update from plugin. extracting info from payload Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:13 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:13 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:13 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:13 volumio volumio[1125]: info: ------------------------------ 14ms Oct 16 04:16:18 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 9 Oct 16 04:16:18 volumio volumio[1125]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 10 Oct 16 04:16:18 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:16:18 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:18 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:16:18 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:22 volumio volumio[1125]: info: CoreCommandRouter::volumioGetState Oct 16 04:16:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPause Oct 16 04:16:22 volumio volumio[1125]: info: CoreStateMachine::pause Oct 16 04:16:22 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:16:22 volumio volumio[1125]: info: CoreStateMachine::servicePause Oct 16 04:16:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:22 volumio volumio[1125]: info: CoreCommandRouter::servicePause Oct 16 04:16:22 volumio volumio[1125]: info: ControllerMpd::pause Oct 16 04:16:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand pause Oct 16 04:16:22 volumio volumio[1125]: info: sendMpdCommand pause took 1 milliseconds Oct 16 04:16:22 volumio volumio[1125]: info: Oct 16 04:16:22 volumio volumio[1125]: ---------------------------- MPD announces state update: player Oct 16 04:16:22 volumio volumio[1125]: info: ControllerMpd::getState Oct 16 04:16:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand status Oct 16 04:16:22 volumio volumio[1125]: info: sendMpdCommand status took 0 milliseconds Oct 16 04:16:22 volumio volumio[1125]: verbose: ControllerMpd::parseState Oct 16 04:16:22 volumio volumio[1125]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 16 04:16:22 volumio volumio[1125]: info: sendMpdCommand playlistinfo took 0 milliseconds Oct 16 04:16:22 volumio volumio[1125]: verbose: ControllerMpd::parseTrackInfo Oct 16 04:16:22 volumio volumio[1125]: info: ControllerMpd::pushState Oct 16 04:16:22 volumio volumio[1125]: info: CoreCommandRouter::servicePushState Oct 16 04:16:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:22 volumio volumio[1125]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":9732,"duration":148,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Bad Boy","artist":"丁克森","album":"中国好声音第二季 第1期","uri":"USB/D48E-B049/中国好声音/bad boy - 丁克森.mp3","trackType":"mp3"} Oct 16 04:16:22 volumio volumio[1125]: verbose: CURRENT POSITION 3 Oct 16 04:16:22 volumio volumio[1125]: info: CoreStateMachine::syncState stateService pause Oct 16 04:16:22 volumio volumio[1125]: info: CoreStateMachine::syncState currentStatus pause Oct 16 04:16:22 volumio volumio[1125]: info: CoreStateMachine::pushState Oct 16 04:16:22 volumio volumio[1125]: info: CorePlayQueue::getTrack 3 Oct 16 04:16:22 volumio volumio[1125]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 16 04:16:22 volumio volumio[1125]: info: CoreCommandRouter::volumioPushState Oct 16 04:16:22 volumio volumio[1125]: info: CoreStateMachine::stPlaybackTimer Oct 16 04:16:22 volumio volumio[1125]: info: ------------------------------ 9ms Oct 16 04:16:22 volumio volumio[1125]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 04:16:22 volumio volumio[1125]: Error: ENOTDIR: not a directory, scandir '/tmp/peppyrunning' Oct 16 04:16:22 volumio volumio[1125]: at Object.readdirSync (fs.js:1048:3) Oct 16 04:16:22 volumio volumio[1125]: at rmkidsSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:349:11) Oct 16 04:16:22 volumio volumio[1125]: at rmdirSync (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:342:7) Oct 16 04:16:22 volumio volumio[1125]: at Function.rimrafSync [as sync] (/data/plugins/user_interface/peppy_screensaver/node_modules/rimraf/rimraf.js:319:62) Oct 16 04:16:22 volumio volumio[1125]: at Object.removeSync (/data/plugins/user_interface/peppy_screensaver/node_modules/fs-extra/lib/remove/index.js:4:17) Oct 16 04:16:22 volumio volumio[1125]: at Socket. (/data/plugins/user_interface/peppy_screensaver/index.js:225:48) Oct 16 04:16:22 volumio volumio[1125]: at Socket.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 16 04:16:22 volumio volumio[1125]: at Socket.onevent (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:278:10) Oct 16 04:16:22 volumio volumio[1125]: at Socket.onpacket (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/socket.js:236:12) Oct 16 04:16:22 volumio volumio[1125]: at Manager. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 16 04:16:22 volumio volumio[1125]: at Manager.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 16 04:16:22 volumio volumio[1125]: at Manager.ondecoded (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:349:8) Oct 16 04:16:22 volumio volumio[1125]: at Decoder. (/data/plugins/user_interface/peppy_screensaver/node_modules/component-bind/index.js:21:15) Oct 16 04:16:22 volumio volumio[1125]: at Decoder.Emitter.emit (/data/plugins/user_interface/peppy_screensaver/node_modules/component-emitter/index.js:145:20) Oct 16 04:16:22 volumio volumio[1125]: at Decoder.add (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-parser/index.js:251:12) Oct 16 04:16:22 volumio volumio[1125]: at Manager.ondata (/data/plugins/user_interface/peppy_screensaver/node_modules/socket.io-client/lib/manager.js:339:16) { Oct 16 04:16:22 volumio volumio[1125]: errno: -20, Oct 16 04:16:22 volumio volumio[1125]: syscall: 'scandir', Oct 16 04:16:22 volumio volumio[1125]: code: 'ENOTDIR', Oct 16 04:16:22 volumio volumio[1125]: path: '/tmp/peppyrunning' Oct 16 04:16:22 volumio volumio[1125]: } Oct 16 04:16:22 volumio volumio[1125]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 16 04:16:22 volumio sudo[3019]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-16 04:15 Oct 16 04:16:22 volumio sudo[3019]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"