-- Logs begin at Thu 2024-09-05 20:11:42 CST, end at Thu 2024-09-05 20:45:58 CST. -- Sep 05 20:44:01 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:44:01 volumio volumio[4436]: info: CURURI: music-library/USB/软件 Sep 05 20:44:01 volumio volumio[4436]: error: Failed LSINFO: null Sep 05 20:44:01 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:44:05 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:44:05 volumio volumio[4436]: info: CURURI: music-library/USB/系统 Sep 05 20:44:05 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/加州旅馆.wav Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/张三的歌.wav Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/渡口.wav Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/阿姐鼓.ape Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/鼓诗.wav Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:44:05 volumio volumio[4436]: info: Preloading song: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:44:05 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/偏偏喜欢你.wav in service mpd Sep 05 20:44:05 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E5%81%8F%E5%81%8F%E5%96%9C%E6%AC%A2%E4%BD%A0.wav&metadata=false Sep 05 20:44:05 volumio volumio[4436]: info: URI /mnt/USB/系统/偏偏喜欢你.wav Sep 05 20:44:05 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/加州旅馆.wav in service mpd Sep 05 20:44:05 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E5%8A%A0%E5%B7%9E%E6%97%85%E9%A6%86.wav&metadata=false Sep 05 20:44:05 volumio volumio[4436]: info: URI /mnt/USB/系统/加州旅馆.wav Sep 05 20:44:05 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/张三的歌.wav in service mpd Sep 05 20:44:05 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E5%BC%A0%E4%B8%89%E7%9A%84%E6%AD%8C.wav&metadata=false Sep 05 20:44:05 volumio volumio[4436]: info: URI /mnt/USB/系统/张三的歌.wav Sep 05 20:44:05 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 in service mpd Sep 05 20:44:05 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20-%20%E9%BC%93%E5%8A%A8%E5%BF%83%E5%BC%A6.mp3&metadata=false Sep 05 20:44:05 volumio volumio[4436]: info: URI /mnt/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/渡口.wav in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E6%B8%A1%E5%8F%A3.wav&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/渡口.wav Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/莫扎特交响乐.wav in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E8%8E%AB%E6%89%8E%E7%89%B9%E4%BA%A4%E5%93%8D%E4%B9%90.wav&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/莫扎特交响乐.wav Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/蔡琴 - 被遗忘的时光.ape in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E8%94%A1%E7%90%B4%20-%20%E8%A2%AB%E9%81%97%E5%BF%98%E7%9A%84%E6%97%B6%E5%85%89.ape&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/超好听的天籁旋律.wav in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E8%B6%85%E5%A5%BD%E5%90%AC%E7%9A%84%E5%A4%A9%E7%B1%81%E6%97%8B%E5%BE%8B.wav&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/超好听的天籁旋律.wav Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/阿姐鼓.ape in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E9%98%BF%E5%A7%90%E9%BC%93.ape&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/阿姐鼓.ape Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/鼓诗.wav in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E9%BC%93%E8%AF%97.wav&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/鼓诗.wav Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/惠威试音碟 - 动感舞曲.ape in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=//extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20-%20%E5%8A%A8%E6%84%9F%E8%88%9E%E6%9B%B2.ape&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=%E9%BB%84%E8%8E%BA%E8%8E%BA/T200A%E8%AF%95%E9%9F%B3%E7%A2%9F/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E8%AF%95%E9%9F%B3%E7%A2%9F%E3%80%81%E9%BB%84%E8%8E%BA%E8%8E%BA%20-%20%E6%83%A0%E5%A8%81.ape&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=%E8%AF%95%E9%9F%B3%E7%A2%9F/%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E5%A4%A9%E7%A2%9F%E2%85%A3/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F%20-%20%E6%83%A0%E5%A8%81%E9%AB%98%E4%BD%8E%E9%9F%B3%E8%AF%95%E9%9F%B3%E7%A2%9F.ape&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=%E8%94%A1%E7%90%B4/%E6%B0%91%E6%AD%8C%2B%E7%B2%BE%E9%80%89/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E8%94%A1%E7%90%B4%20-%20%E4%BD%A0%E7%9A%84%E7%9C%BC%E7%A5%9E%20-%20%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E7%A2%9F.ape&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:44:06 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape in service mpd Sep 05 20:44:06 volumio volumio[4436]: info: ALBUMART /albumart?cacheid=943&web=%E5%8F%91%E7%83%A7%E8%AF%95%E9%9F%B3%E7%A2%9F/%E9%87%91%E8%80%B3%E6%9C%B5%E2%85%A2/extralarge&path=%2Fmnt%2FUSB%2F%E7%B3%BB%E7%BB%9F%2F%E6%9C%A8%E6%9D%91%E5%A5%BD%E5%A4%AB%20-%20%E5%90%89%E4%BB%96%20-%20%E6%83%A0%E5%A8%81%E8%AF%95%E9%9F%B3%E5%A4%A9%E7%A2%9F%20%E6%9F%B3%E6%BF%91%E5%B0%8F%E9%95%87.ape&metadata=false Sep 05 20:44:06 volumio volumio[4436]: info: URI /mnt/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:07 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::ClearQueue Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::serviceStop Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::serviceStop Sep 05 20:44:09 volumio volumio[4436]: info: Airplay Stop Sep 05 20:44:09 volumio volumio[4436]: info: Stopping Airplay Playback and sending pause command to client via USR2 Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::clearPlayQueue Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::addQueueItems Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::addQueueItems Sep 05 20:44:09 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/加州旅馆.wav Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/加州旅馆.wav Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/张三的歌.wav Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/张三的歌.wav Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/渡口.wav Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/渡口.wav Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/阿姐鼓.ape Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/阿姐鼓.ape Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/鼓诗.wav Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/鼓诗.wav Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:44:09 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:44:09 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:44:09 volumio volumio[4436]: info: Exploding uri music-library/USB/系统/$RECYCLE.BIN in service mpd Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPlay Sep 05 20:44:09 volumio volumio[4436]: verbose: UNSET VOLATILE: Service: airplay_emulation Sep 05 20:44:09 volumio volumio[4436]: info: Stopping Airplay Playback and sending pause command to client via USR2 Sep 05 20:44:09 volumio sudo[5677]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 4620 Sep 05 20:44:09 volumio sudo[5677]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:09 volumio sudo[5677]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::play index 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::stPlaybackTimer Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::serviceStop Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::serviceStop Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::stop Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand stop took 1 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::startPlaybackTimer Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/偏偏喜欢你.wav Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:44:09 volumio volumio[4436]: info: Shairport-Sync paused with USR2 Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand stop took 1 milliseconds Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:09 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand clear took 2 milliseconds Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/偏偏喜欢你.wav" Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:09 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:09 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:09 volumio sudo[5681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/kill -USR2 4620 Sep 05 20:44:09 volumio sudo[5681]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:09 volumio volumio[4436]: error: updateQueue error: null Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:09 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 9ms Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand add "USB/系统/偏偏喜欢你.wav" took 8 milliseconds Sep 05 20:44:09 volumio sudo[5681]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 8ms Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand play Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:09 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:09 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 5ms Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand play took 4 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 3ms Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 3ms Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:09 volumio volumio[4436]: info: Shairport-Sync paused with USR2 Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand status took 75 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand status took 74 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand status took 74 milliseconds Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:09 volumio volumio[4436]: info: Sep 05 20:44:09 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand status took 8 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand status took 7 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand status took 7 milliseconds Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"偏偏喜欢你.wav","artist":null,"album":null,"uri":"USB/系统/偏偏喜欢你.wav","trackType":"wav"} Sep 05 20:44:09 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"偏偏喜欢你.wav","artist":null,"album":null,"uri":"USB/系统/偏偏喜欢你.wav","trackType":"wav"} Sep 05 20:44:09 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:09 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"偏偏喜欢你.wav","artist":null,"album":null,"uri":"USB/系统/偏偏喜欢你.wav","trackType":"wav"} Sep 05 20:44:09 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:09 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 88ms Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 90ms Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 90ms Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 10 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:44:09 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:09 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"偏偏喜欢你.wav","artist":null,"album":null,"uri":"USB/系统/偏偏喜欢你.wav","trackType":"wav"} Sep 05 20:44:09 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:09 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"偏偏喜欢你.wav","artist":null,"album":null,"uri":"USB/系统/偏偏喜欢你.wav","trackType":"wav"} Sep 05 20:44:09 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:09 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":214,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"偏偏喜欢你.wav","artist":null,"album":null,"uri":"USB/系统/偏偏喜欢你.wav","trackType":"wav"} Sep 05 20:44:09 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:09 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:09 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:09 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 31ms Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 29ms Sep 05 20:44:09 volumio volumio[4436]: info: ------------------------------ 30ms Sep 05 20:44:10 volumio volumio[4436]: info: Restarting Shairport-Sync after stop Sep 05 20:44:10 volumio sudo[5690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:44:10 volumio sudo[5690]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 20:44:10 volumio shairport-sync[4620]: {"time":1725540044277,"response":"startAirplayPlayback Success"} Sep 05 20:44:10 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 20:44:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 20:44:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 20:44:10 volumio sudo[5690]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:10 volumio volumio[4436]: info: Shairport-Sync retarted Sep 05 20:44:10 volumio volumio[4436]: info: Restarting Shairport-Sync after stop Sep 05 20:44:10 volumio sudo[5696]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Sep 05 20:44:10 volumio sudo[5696]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Sep 05 20:44:10 volumio systemd[1]: shairport-sync.service: Succeeded. Sep 05 20:44:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Sep 05 20:44:10 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Sep 05 20:44:10 volumio sudo[5696]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:10 volumio volumio[4436]: info: Shairport-Sync retarted Sep 05 20:44:34 volumio volumio[4436]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:44:34 volumio volumio[4436]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Sep 05 20:44:34 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:44:34 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Sep 05 20:44:34 volumio sudo[5708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Sep 05 20:44:34 volumio sudo[5708]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5708]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio sudo[5714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 05 20:44:34 volumio sudo[5714]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 05 20:44:34 volumio sudo[5723]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5714]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio sudo[5733]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 05 20:44:34 volumio sudo[5733]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5723]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio sudo[5743]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:34 volumio sudo[5743]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5743]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio sudo[5733]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 05 20:44:34 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 05 20:44:34 volumio sudo[5749]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:34 volumio sudo[5749]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5749]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio sudo[5753]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 05 20:44:34 volumio sudo[5753]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5753]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio volumio[4436]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 05 20:44:34 volumio volumio[4436]: wlan0 Interface doesn't support scanning. Sep 05 20:44:34 volumio volumio[4436]: info: Cannot use regular scanning, forcing with ap-force Sep 05 20:44:34 volumio sudo[5759]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 05 20:44:34 volumio sudo[5759]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:34 volumio sudo[5759]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:34 volumio volumio[4436]: command failed: No such device (-19) Sep 05 20:44:34 volumio volumio[4436]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 05 20:44:34 volumio volumio[4436]: command failed: No such device (-19) Sep 05 20:44:51 volumio sudo[5809]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:51 volumio sudo[5809]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:51 volumio sudo[5809]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:51 volumio sudo[5812]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:51 volumio sudo[5812]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:51 volumio sudo[5812]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:51 volumio volumio[4436]: verbose: New Socket.io Connection to 192.168.1.7 from 192.168.1.6 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/112.0.0.0 Safari/537.36 Total Clients: 7 Sep 05 20:44:52 volumio sudo[5817]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:44:52 volumio sudo[5817]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:52 volumio sudo[5817]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:52 volumio sudo[5820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:44:52 volumio sudo[5820]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:44:52 volumio sudo[5820]: pam_unix(sudo:session): session closed for user root Sep 05 20:44:52 volumio volumio[4436]: verbose: New Socket.io Connection to 192.168.1.7 from 192.168.1.6 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/112.0.0.0 Safari/537.36 Total Clients: 8 Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::volumioGetVisibleSources Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:52 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Sep 05 20:44:52 volumio volumio[4436]: info: Received Get System Info Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:44:52 volumio volumio[4436]: info: Discovery: Getting this device information Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:52 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:52 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:52 volumio volumio[4436]: info: Listing playlists Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Sep 05 20:44:52 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Sep 05 20:44:53 volumio volumio[4436]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:53 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:54 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Sep 05 20:44:54 volumio volumio[4436]: info: Received Get System Info Sep 05 20:44:54 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Sep 05 20:44:54 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Sep 05 20:44:54 volumio volumio[4436]: info: Discovery: Getting this device information Sep 05 20:44:54 volumio volumio[4436]: info: CoreCommandRouter::volumioGetState Sep 05 20:44:54 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:54 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioNext Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::next Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::stPlaybackTimer Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::serviceStop Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::serviceStop Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::stop Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand stop took 12 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::startPlaybackTimer Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/加州旅馆.wav Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand stop took 2 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 0 milliseconds Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:55 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand clear took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/加州旅馆.wav" Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 20:44:55 volumio volumio[4436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 20:44:55 volumio volumio[4436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 6ms Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 5ms Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:55 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:55 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:55 volumio volumio[4436]: error: updateQueue error: null Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:55 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 4ms Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand add "USB/系统/加州旅馆.wav" took 3 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 1ms Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand play Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:55 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:44:55 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 5ms Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand play took 4 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 4ms Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 4ms Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 0 milliseconds Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: Sep 05 20:44:55 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:44:55 volumio volumio[4436]: verbose: CURRENT POSITION 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:44:55 volumio volumio[4436]: verbose: CURRENT POSITION 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:55 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:44:55 volumio volumio[4436]: verbose: CURRENT POSITION 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:55 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 8ms Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 11ms Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 10ms Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand status took 9 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 8 milliseconds Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:44:55 volumio volumio[4436]: verbose: CURRENT POSITION 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:55 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:44:55 volumio volumio[4436]: verbose: CURRENT POSITION 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:55 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 20ms Sep 05 20:44:55 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 05 20:44:55 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:44:55 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":478,"duration":258,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:44:55 volumio volumio[4436]: verbose: CURRENT POSITION 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:44:55 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:44:55 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:44:55 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:44:55 volumio volumio[4436]: info: ------------------------------ 31ms Sep 05 20:45:00 volumio volumio[4436]: info: CoreCommandRouter::getUIConfigOnPlugin Sep 05 20:45:00 volumio volumio[4436]: /bin/cat: /sys/class/net/wlan0/flags: No such file or directory Sep 05 20:45:00 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Sep 05 20:45:00 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getInfoNetwork Sep 05 20:45:00 volumio sudo[5828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ethtool eth0 Sep 05 20:45:00 volumio sudo[5828]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5828]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio sudo[5834]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 05 20:45:00 volumio sudo[5834]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5842]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 05 20:45:00 volumio sudo[5842]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5834]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio sudo[5853]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwconfig wlan0 Sep 05 20:45:00 volumio sudo[5853]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5842]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio sudo[5863]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Sep 05 20:45:00 volumio sudo[5863]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5853]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio sudo[5863]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworksScanCache Sep 05 20:45:00 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: network , getWirelessNetworks Sep 05 20:45:00 volumio sudo[5869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Sep 05 20:45:00 volumio sudo[5869]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5869]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio sudo[5874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Sep 05 20:45:00 volumio sudo[5874]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5874]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio volumio[4436]: error: An error occurred while scanning: Error: Command failed: sudo /sbin/iwlist wlan0 scan Sep 05 20:45:00 volumio volumio[4436]: wlan0 Interface doesn't support scanning. Sep 05 20:45:00 volumio volumio[4436]: info: Cannot use regular scanning, forcing with ap-force Sep 05 20:45:00 volumio sudo[5879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iw dev wlan0 scan ap-force Sep 05 20:45:00 volumio sudo[5879]: pam_unix(sudo:session): session opened for user root by (uid=0) Sep 05 20:45:00 volumio sudo[5879]: pam_unix(sudo:session): session closed for user root Sep 05 20:45:00 volumio volumio[4436]: command failed: No such device (-19) Sep 05 20:45:00 volumio volumio[4436]: error: Cannot use fallback scanning method: Error: Command failed: /usr/bin/sudo /sbin/iw dev wlan0 scan ap-force Sep 05 20:45:00 volumio volumio[4436]: command failed: No such device (-19) Sep 05 20:45:06 volumio volumio[4436]: info: CoreCommandRouter::volumioGetState Sep 05 20:45:06 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:45:07 volumio volumio[4436]: info: CoreCommandRouter::volumioGetQueue Sep 05 20:45:07 volumio volumio[4436]: info: CoreStateMachine::getQueue Sep 05 20:45:07 volumio volumio[4436]: info: CorePlayQueue::getQueue Sep 05 20:45:10 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::ClearQueue Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::stPlaybackTimer Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::serviceStop Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 1 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::serviceStop Sep 05 20:45:10 volumio volumio[4436]: info: ControllerMpd::stop Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::clearPlayQueue Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::addQueueItems Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::addQueueItems Sep 05 20:45:10 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:10 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/9280B1B080B19AE5/陈瑞 Sep 05 20:45:10 volumio volumio[4436]: info: Exploding uri music-library/USB/9280B1B080B19AE5/陈瑞 in service mpd Sep 05 20:45:10 volumio volumio[4436]: error: scanFolder - failure to stat '/mnt/USB/9280B1B080B19AE5/陈瑞' Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPlay Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::play index 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: Sep 05 20:45:10 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:10 volumio volumio[4436]: info: sendMpdCommand stop took 12 milliseconds Sep 05 20:45:10 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:10 volumio volumio[4436]: info: Sep 05 20:45:10 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:10 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:10 volumio volumio[4436]: info: Sep 05 20:45:10 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:10 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:10 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:10 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:10 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:10 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 20:45:10 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 20:45:10 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 1 milliseconds Sep 05 20:45:10 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:10 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: 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":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:45:10 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: No code Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: 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":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:45:10 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: No code Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: 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":"加州旅馆.wav","artist":null,"album":null,"uri":"USB/系统/加州旅馆.wav","trackType":"wav"} Sep 05 20:45:10 volumio volumio[4436]: verbose: CURRENT POSITION 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: No code Sep 05 20:45:10 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:10 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:10 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:10 volumio volumio[4436]: info: ------------------------------ 19ms Sep 05 20:45:10 volumio volumio[4436]: info: ------------------------------ 18ms Sep 05 20:45:10 volumio volumio[4436]: info: ------------------------------ 18ms Sep 05 20:45:12 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:12 volumio volumio[4436]: info: CURURI: music-library/USB/9280B1B080B19AE5/陈瑞 Sep 05 20:45:12 volumio volumio[4436]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Sep 05 20:45:12 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:22 volumio volumio[4436]: info: CoreCommandRouter::volumioGetState Sep 05 20:45:22 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:22 volumio volumio[4436]: info: CoreCommandRouter::volumioPlay Sep 05 20:45:22 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:45:22 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:22 volumio volumio[4436]: info: CorePlayQueue::getTrack 0 Sep 05 20:45:28 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:28 volumio volumio[4436]: info: CURURI: playlists Sep 05 20:45:28 volumio volumio[4436]: info: Listing playlists Sep 05 20:45:28 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:31 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:31 volumio volumio[4436]: info: CURURI: music-library Sep 05 20:45:31 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:34 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:34 volumio volumio[4436]: info: CURURI: music-library/INTERNAL Sep 05 20:45:34 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:35 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:35 volumio volumio[4436]: info: CURURI: music-library/INTERNAL/peppy_screensaver Sep 05 20:45:35 volumio volumio[4436]: error: Failed LSINFO: null Sep 05 20:45:35 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:38 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:38 volumio volumio[4436]: info: CURURI: music-library Sep 05 20:45:38 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:39 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:39 volumio volumio[4436]: info: CURURI: music-library/USB Sep 05 20:45:39 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:39 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Sep 05 20:45:39 volumio volumio[4436]: info: CURURI: music-library/USB/系统 Sep 05 20:45:39 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:41 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:41 volumio volumio[4436]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::ClearQueue Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:41 volumio volumio[4436]: info: CorePlayQueue::clearPlayQueue Sep 05 20:45:41 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:41 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::addQueueItems Sep 05 20:45:41 volumio volumio[4436]: info: CorePlayQueue::addQueueItems Sep 05 20:45:41 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/张三的歌.wav Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/张三的歌.wav Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/渡口.wav Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/渡口.wav Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/鼓诗.wav Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/鼓诗.wav Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:41 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:41 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:41 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:41 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:41 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:41 volumio volumio[4436]: info: CoreCommandRouter::volumioPlay Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::play index 4 Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:41 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:41 volumio volumio[4436]: info: CoreStateMachine::startPlaybackTimer Sep 05 20:45:41 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/渡口.wav Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:41 volumio volumio[4436]: info: sendMpdCommand stop took 1 milliseconds Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:41 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:41 volumio volumio[4436]: info: sendMpdCommand clear took 1 milliseconds Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/渡口.wav" Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:41 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:41 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:41 volumio volumio[4436]: error: updateQueue error: null Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:41 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:41 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:41 volumio volumio[4436]: info: sendMpdCommand add "USB/系统/渡口.wav" took 1 milliseconds Sep 05 20:45:41 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:41 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand play Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:41 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:41 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:41 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:41 volumio volumio[4436]: info: sendMpdCommand play took 1 milliseconds Sep 05 20:45:41 volumio volumio[4436]: info: ------------------------------ 1ms Sep 05 20:45:41 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:41 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:41 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:41 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:41 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:41 volumio volumio[4436]: info: Sep 05 20:45:41 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand status took 5 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand status took 4 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand status took 3 milliseconds Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:42 volumio volumio[4436]: info: Sep 05 20:45:42 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:42 volumio volumio[4436]: info: Sep 05 20:45:42 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand status took 3 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 2 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"渡口.wav","artist":null,"album":null,"uri":"USB/系统/渡口.wav","trackType":"wav"} Sep 05 20:45:42 volumio volumio[4436]: verbose: CURRENT POSITION 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"渡口.wav","artist":null,"album":null,"uri":"USB/系统/渡口.wav","trackType":"wav"} Sep 05 20:45:42 volumio volumio[4436]: verbose: CURRENT POSITION 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:42 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"渡口.wav","artist":null,"album":null,"uri":"USB/系统/渡口.wav","trackType":"wav"} Sep 05 20:45:42 volumio volumio[4436]: verbose: CURRENT POSITION 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:42 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: ------------------------------ 15ms Sep 05 20:45:42 volumio volumio[4436]: info: ------------------------------ 16ms Sep 05 20:45:42 volumio volumio[4436]: info: ------------------------------ 17ms Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:45:42 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:42 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"渡口.wav","artist":null,"album":null,"uri":"USB/系统/渡口.wav","trackType":"wav"} Sep 05 20:45:42 volumio volumio[4436]: verbose: CURRENT POSITION 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:42 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"渡口.wav","artist":null,"album":null,"uri":"USB/系统/渡口.wav","trackType":"wav"} Sep 05 20:45:42 volumio volumio[4436]: verbose: CURRENT POSITION 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:42 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"渡口.wav","artist":null,"album":null,"uri":"USB/系统/渡口.wav","trackType":"wav"} Sep 05 20:45:42 volumio volumio[4436]: verbose: CURRENT POSITION 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:42 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:42 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:42 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:42 volumio volumio[4436]: info: ------------------------------ 23ms Sep 05 20:45:42 volumio volumio[4436]: info: ------------------------------ 20ms Sep 05 20:45:42 volumio volumio[4436]: info: ------------------------------ 20ms Sep 05 20:45:47 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:47 volumio volumio[4436]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::ClearQueue Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::stPlaybackTimer Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:47 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:47 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::serviceStop Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::getTrack 4 Sep 05 20:45:47 volumio volumio[4436]: info: CoreCommandRouter::serviceStop Sep 05 20:45:47 volumio volumio[4436]: info: ControllerMpd::stop Sep 05 20:45:47 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::clearPlayQueue Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:47 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::addQueueItems Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::addQueueItems Sep 05 20:45:47 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/张三的歌.wav Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/张三的歌.wav Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/渡口.wav Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/渡口.wav Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/鼓诗.wav Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/鼓诗.wav Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:47 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:47 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:47 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:47 volumio volumio[4436]: info: CoreCommandRouter::volumioPlay Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::play index 8 Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:47 volumio volumio[4436]: info: CoreStateMachine::startPlaybackTimer Sep 05 20:45:47 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:47 volumio volumio[4436]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/阿姐鼓.ape Sep 05 20:45:47 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand stop took 29 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand stop took 22 milliseconds Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:48 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 8 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand clear took 6 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 7 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 5 milliseconds Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/阿姐鼓.ape" Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: No code Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: No code Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 20ms Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 20ms Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:48 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:48 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:48 volumio volumio[4436]: error: updateQueue error: null Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:48 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 24ms Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 23 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand add "USB/系统/阿姐鼓.ape" took 22 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 9ms Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand play Sep 05 20:45:48 volumio volumio[4436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 40ms Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:48 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:48 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 16ms Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand play took 14 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 7ms Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 7ms Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 6 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 5 milliseconds Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿姐鼓.ape","artist":null,"album":null,"uri":"USB/系统/阿姐鼓.ape","trackType":"ape"} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿姐鼓.ape","artist":null,"album":null,"uri":"USB/系统/阿姐鼓.ape","trackType":"ape"} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:48 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿姐鼓.ape","artist":null,"album":null,"uri":"USB/系统/阿姐鼓.ape","trackType":"ape"} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:48 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 14ms Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 17ms Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 16ms Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: Sep 05 20:45:48 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿姐鼓.ape","artist":null,"album":null,"uri":"USB/系统/阿姐鼓.ape","trackType":"ape"} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:48 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 30ms Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 17 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand status took 16 milliseconds Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 05 20:45:48 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 3 milliseconds Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:48 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿姐鼓.ape","artist":null,"album":null,"uri":"USB/系统/阿姐鼓.ape","trackType":"ape"} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:48 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":348,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"阿姐鼓.ape","artist":null,"album":null,"uri":"USB/系统/阿姐鼓.ape","trackType":"ape"} Sep 05 20:45:48 volumio volumio[4436]: verbose: CURRENT POSITION 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:48 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:48 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:48 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 31ms Sep 05 20:45:48 volumio volumio[4436]: info: ------------------------------ 30ms Sep 05 20:45:49 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::ClearQueue Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::stPlaybackTimer Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::serviceStop Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 8 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::serviceStop Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::stop Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::clearPlayQueue Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::addQueueItems Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::addQueueItems Sep 05 20:45:49 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/张三的歌.wav Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/张三的歌.wav Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/渡口.wav Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/渡口.wav Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/鼓诗.wav Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/鼓诗.wav Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:49 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:49 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPlay Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::play index 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::startPlaybackTimer Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/鼓诗.wav Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand stop took 11 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand stop took 5 milliseconds Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:49 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand clear took 1 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/鼓诗.wav" Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: No code Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: No code Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 11ms Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 10ms Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:49 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:49 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:49 volumio volumio[4436]: error: updateQueue error: null Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:49 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 12ms Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 11 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand add "USB/系统/鼓诗.wav" took 11 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 1ms Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand play Sep 05 20:45:49 volumio volumio[4436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 15ms Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:49 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:49 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 3ms Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand play took 2 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 3ms Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 3 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 3 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: Sep 05 20:45:49 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 6 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 6 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand status took 5 milliseconds Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"鼓诗.wav","artist":null,"album":null,"uri":"USB/系统/鼓诗.wav","trackType":"wav"} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"鼓诗.wav","artist":null,"album":null,"uri":"USB/系统/鼓诗.wav","trackType":"wav"} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:49 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"鼓诗.wav","artist":null,"album":null,"uri":"USB/系统/鼓诗.wav","trackType":"wav"} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:49 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 22ms Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 24ms Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 25ms Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 16 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 05 20:45:49 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 15 milliseconds Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:49 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"鼓诗.wav","artist":null,"album":null,"uri":"USB/系统/鼓诗.wav","trackType":"wav"} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:49 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":136,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"鼓诗.wav","artist":null,"album":null,"uri":"USB/系统/鼓诗.wav","trackType":"wav"} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:49 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":705,"duration":221,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"鼓诗.wav","artist":null,"album":null,"uri":"USB/系统/鼓诗.wav","trackType":"wav"} Sep 05 20:45:49 volumio volumio[4436]: verbose: CURRENT POSITION 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:49 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:49 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:49 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 33ms Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 31ms Sep 05 20:45:49 volumio volumio[4436]: info: ------------------------------ 30ms Sep 05 20:45:51 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioReplaceandPlayItems Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::ClearQueue Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::stPlaybackTimer Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::serviceStop Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 9 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::serviceStop Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::stop Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::clearPlayQueue Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::addQueueItems Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::addQueueItems Sep 05 20:45:51 volumio volumio[4436]: info: Preload queue cleared Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/偏偏喜欢你.wav Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/加州旅馆.wav Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/张三的歌.wav Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/张三的歌.wav Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 鼓动心弦.mp3 Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/渡口.wav Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/渡口.wav Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/莫扎特交响乐.wav Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 被遗忘的时光.ape Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/超好听的天籁旋律.wav Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/阿姐鼓.ape Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/鼓诗.wav Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/鼓诗.wav Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 动感舞曲.ape Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/惠威试音碟 - 惠威高低音试音碟.ape Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/蔡琴 - 你的眼神 - 惠威试音碟.ape Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/木村好夫 - 吉他 - 惠威试音天碟 柳濑小镇.ape Sep 05 20:45:51 volumio volumio[4436]: info: Adding Item to queue: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:51 volumio volumio[4436]: info: Using cached record of: music-library/USB/系统/$RECYCLE.BIN Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushQueue Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::saveQueue Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::updateTrackBlock Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrackBlock Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPlay Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::play index 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::stop Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::play index undefined Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::setConsumeUpdateService undefined Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::startPlaybackTimer Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::clearAddPlayTracks USB/系统/试音碟、黄莺莺 - 惠威.ape Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand stop Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand stop took 23 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand stop took 18 milliseconds Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand clear Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:51 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand clear took 1 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 1 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 0 milliseconds Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand add "USB/系统/试音碟、黄莺莺 - 惠威.ape" Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: No code Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService stop Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: No code Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 10ms Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 11ms Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:51 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:51 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:51 volumio volumio[4436]: error: updateQueue error: null Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:51 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 12ms Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 11 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand add "USB/系统/试音碟、黄莺莺 - 惠威.ape" took 11 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 2ms Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 1ms Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand play Sep 05 20:45:51 volumio volumio[4436]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 14ms Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:51 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces system playlist update Sep 05 20:45:51 volumio volumio[4436]: info: Ignoring MPD Status Update Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 6ms Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand play took 5 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 5ms Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 5ms Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 3 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 2 milliseconds Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: Sep 05 20:45:51 volumio volumio[4436]: ---------------------------- MPD announces state update: player Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::getState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand status Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 7 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 7 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 6 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand status took 6 milliseconds Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseState Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::sendMpdCommand playlistinfo Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"葬心","artist":"黄莺莺","album":"T200A试音碟","uri":"USB/系统/试音碟、黄莺莺 - 惠威.ape","trackType":"ape"} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus stop Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"葬心","artist":"黄莺莺","album":"T200A试音碟","uri":"USB/系统/试音碟、黄莺莺 - 惠威.ape","trackType":"ape"} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:51 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"葬心","artist":"黄莺莺","album":"T200A试音碟","uri":"USB/系统/试音碟、黄莺莺 - 惠威.ape","trackType":"ape"} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:51 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 16ms Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 17ms Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 18ms Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:45:51 volumio volumio[4436]: info: sendMpdCommand playlistinfo took 9 milliseconds Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:51 volumio volumio[4436]: verbose: ControllerMpd::parseTrackInfo Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"葬心","artist":"黄莺莺","album":"T200A试音碟","uri":"USB/系统/试音碟、黄莺莺 - 惠威.ape","trackType":"ape"} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:51 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"葬心","artist":"黄莺莺","album":"T200A试音碟","uri":"USB/系统/试音碟、黄莺莺 - 惠威.ape","trackType":"ape"} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:51 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: ControllerMpd::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::servicePushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":304,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"葬心","artist":"黄莺莺","album":"T200A试音碟","uri":"USB/系统/试音碟、黄莺莺 - 惠威.ape","trackType":"ape"} Sep 05 20:45:51 volumio volumio[4436]: verbose: CURRENT POSITION 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState stateService play Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::syncState currentStatus play Sep 05 20:45:51 volumio volumio[4436]: info: Received an update from plugin. extracting info from payload Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: CoreStateMachine::pushState Sep 05 20:45:51 volumio volumio[4436]: info: CorePlayQueue::getTrack 11 Sep 05 20:45:51 volumio volumio[4436]: info: CoreCommandRouter::volumioPushState Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 29ms Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 28ms Sep 05 20:45:51 volumio volumio[4436]: info: ------------------------------ 28ms Sep 05 20:45:58 volumio volumio[4436]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 20:45:58 volumio volumio[4436]: Error: connect ETIMEDOUT 103.252.115.169:80 Sep 05 20:45:58 volumio volumio[4436]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Sep 05 20:45:58 volumio volumio[4436]: errno: -110, Sep 05 20:45:58 volumio volumio[4436]: code: 'ETIMEDOUT', Sep 05 20:45:58 volumio volumio[4436]: syscall: 'connect', Sep 05 20:45:58 volumio volumio[4436]: address: '103.252.115.169', Sep 05 20:45:58 volumio volumio[4436]: port: 80 Sep 05 20:45:58 volumio volumio[4436]: } Sep 05 20:45:58 volumio volumio[4436]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Sep 05 20:45:58 volumio sudo[5950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-09-05 20:44 Sep 05 20:45:58 volumio sudo[5950]: 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="e7445fab547cd22e23d9bef72406cfb610bc1d7d" VOLUMIO_FE_VERSION="5d5e99f8f803b3ec5fc5e8ca13bb4023600f3eee" VOLUMIO_FE3_VERSION="a6ae210575eae1ff43f06ab71e1cd17576840623" VOLUMIO_BE_VERSION="a9e1e1dd6072ffb15c0fcb8938d9ea0d8900c0da" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 24 Apr 2024 02:42:03 PM CEST" VOLUMIO_VERSION="3.661" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="c434411fe8754b648dc7feb1d8f43761"