-- Logs begin at Thu 2019-02-14 18:12:00 CST, end at Sat 2025-07-05 12:30:14 CST. -- Jul 05 12:29:00 volumio volumio[3039]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%B0%8F%E9%98%BF%E4%B8%83/%E4%BB%8E%E5%89%8D%E8%AF%B4/9b39369e-e6cc-4cf5-a0c9-20803d1d0009.jpg' Jul 05 12:29:00 volumio volumio[3039]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%AC%A2%E5%AD%90/%E5%85%B6%E5%AE%9E%E5%BE%88%E5%AF%82%E5%AF%9E/9ef02850-770c-416e-8279-935261314f2e.jpg' Jul 05 12:29:00 volumio volumio[3039]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E4%BA%8E%E5%86%AC%E7%84%B6/%E5%85%B6%E5%AE%9E%E9%83%BD%E6%B2%A1%E6%9C%89/cf86694f-f1af-40c7-a0a9-5e863d3518da.jpg' Jul 05 12:29:00 volumio volumio[3039]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%87%A4%E5%87%B0%E4%BC%A0%E5%A5%87/%E6%9C%80%E7%82%AB%E6%B0%91%E6%97%8F%E9%A3%8E/23f2ae6e-305a-4ca0-8f25-7682bc5bda73.jpg' Jul 05 12:29:00 volumio volumio[3039]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E6%9D%8E%E7%8E%89%E5%88%9A/%E5%88%9A%E5%A5%BD%E9%81%87%E8%A7%81%E4%BD%A0/634134c4-dc98-4c09-8c8d-6e3c74c4ed8e.jpg' Jul 05 12:29:00 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jul 05 12:29:00 volumio volumio[3039]: info: Received Get System Info Jul 05 12:29:00 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jul 05 12:29:00 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jul 05 12:29:00 volumio volumio[3039]: info: Discovery: Getting this device information Jul 05 12:29:00 volumio volumio[3039]: info: CoreCommandRouter::volumioGetState Jul 05 12:29:00 volumio volumio[3039]: info: CorePlayQueue::getTrack 2 Jul 05 12:29:00 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 05 12:29:00 volumio volumio[3039]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%91%A8%E6%9D%B0%E4%BC%A6/%E5%8D%81%E4%BA%8C%E6%96%B0%E4%BD%9C/b4523dd1-5e28-49e6-a0ce-8c1570c39102.jpg' Jul 05 12:29:00 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPlay Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::play index 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::stPlaybackTimer Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::updateTrackBlock Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrackBlock Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 2 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::serviceStop Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 2 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::serviceStop Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::stop Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand stop took 22 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::play index undefined Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::clearAddPlayTracks USB/469A-F83B/song/林俊杰-我还想她.mp3 Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 5 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand stop took 2 milliseconds Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 9 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand clear took 10 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 13 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 11 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 10 milliseconds Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand add "USB/469A-F83B/song/林俊杰-我还想她.mp3" Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: 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":"大眠","artist":"王心凌","album":"CYNDILOVES2SING 爱。心凌","uri":"USB/469A-F83B/song/王心凌-大眠.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: No code Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: 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} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: No code Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: 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} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: No code Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: 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} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: No code Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 135ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 128ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 127ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 126ms Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: error: updateQueue error: null Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 134ms Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand add "USB/469A-F83B/song/林俊杰-我还想她.mp3" took 124 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 9ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 7ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 6ms Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:01 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 34ms Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand play took 32 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 32ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 31ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 29ms Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 14 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 13 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 12 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 10 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 8 milliseconds Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: Jul 05 12:29:01 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 10 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 9 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand status took 6 milliseconds Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:01 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:01 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:01 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:01 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 107ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 194ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 192ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 192ms Jul 05 12:29:01 volumio volumio[3039]: info: ------------------------------ 192ms Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 174 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 174 milliseconds Jul 05 12:29:01 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 174 milliseconds Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:01 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:01 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":248,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"我还想她","artist":"林俊杰","album":"JJ陆","uri":"USB/469A-F83B/song/林俊杰-我还想她.mp3","trackType":"mp3"} Jul 05 12:29:01 volumio volumio[3039]: verbose: CURRENT POSITION 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:01 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:01 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:01 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:01 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:02 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:02 volumio volumio[3039]: info: ------------------------------ 294ms Jul 05 12:29:02 volumio volumio[3039]: info: ------------------------------ 294ms Jul 05 12:29:02 volumio volumio[3039]: info: ------------------------------ 294ms Jul 05 12:29:08 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:08 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:08 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:08 volumio volumio[3039]: info: CoreStateMachine::setRandom true Jul 05 12:29:08 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:08 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:08 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:08 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:08 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jul 05 12:29:09 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:09 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:09 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:09 volumio volumio[3039]: info: CoreStateMachine::setRandom false Jul 05 12:29:09 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:09 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:09 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:09 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:10 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:10 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:10 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:10 volumio volumio[3039]: info: CoreStateMachine::setRandom true Jul 05 12:29:10 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:10 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:10 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:10 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:11 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:11 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:11 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:11 volumio volumio[3039]: info: CoreStateMachine::setRepeat true single false Jul 05 12:29:11 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:11 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:11 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:11 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:12 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:12 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:12 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:12 volumio volumio[3039]: info: CoreStateMachine::setRandom false Jul 05 12:29:12 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:12 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:12 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:12 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:13 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:13 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:13 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:13 volumio volumio[3039]: info: CoreStateMachine::setRepeat true single true Jul 05 12:29:13 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:13 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:13 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:13 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:14 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:14 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:14 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:14 volumio volumio[3039]: info: CoreStateMachine::setRepeat false single false Jul 05 12:29:14 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:14 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:14 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:14 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:15 volumio ntpd[749]: 193.182.111.142 local addr 192.168.10.24 -> Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:15 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:15 volumio volumio[3039]: info: CoreStateMachine::setRandom true Jul 05 12:29:15 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:15 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:15 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:15 volumio volumio[3039]: info: CoreStateMachine::setRandom false Jul 05 12:29:15 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:15 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:15 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:16 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:16 volumio volumio[3039]: info: CoreStateMachine::setRandom true Jul 05 12:29:16 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:16 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:16 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:16 volumio volumio[3039]: info: CoreStateMachine::setRandom false Jul 05 12:29:16 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:16 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:16 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:17 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:17 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:17 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:17 volumio volumio[3039]: info: CoreStateMachine::setRepeat true single false Jul 05 12:29:17 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:17 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:17 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:17 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:18 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:18 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:18 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:18 volumio volumio[3039]: info: CoreStateMachine::setRepeat true single true Jul 05 12:29:18 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:18 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:18 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:18 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:19 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:19 volumio volumio[3039]: info: CoreStateMachine::setRepeat false single false Jul 05 12:29:19 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:19 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::volumioRandom Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::writePlayerControls Jul 05 12:29:19 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:19 volumio volumio[3039]: info: CoreStateMachine::setRandom true Jul 05 12:29:19 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:19 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:19 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:23 volumio kernel: hwmon hwmon1: Voltage normalised Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPlay Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::play index 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::stop Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::stPlaybackTimer Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::updateTrackBlock Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrackBlock Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::serviceStop Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 5 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::serviceStop Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::stop Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:28 volumio volumio[3039]: info: sendMpdCommand stop took 23 milliseconds Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::play index undefined Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::clearAddPlayTracks USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3 Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:28 volumio volumio[3039]: info: sendMpdCommand stop took 4 milliseconds Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:28 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:28 volumio volumio[3039]: info: sendMpdCommand status took 15 milliseconds Jul 05 12:29:28 volumio volumio[3039]: info: sendMpdCommand clear took 14 milliseconds Jul 05 12:29:28 volumio volumio[3039]: info: sendMpdCommand status took 11 milliseconds Jul 05 12:29:28 volumio volumio[3039]: info: sendMpdCommand status took 9 milliseconds Jul 05 12:29:28 volumio volumio[3039]: info: sendMpdCommand status took 7 milliseconds Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand add "USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3" Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:28 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: 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} Jul 05 12:29:28 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: No code Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: 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} Jul 05 12:29:28 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: No code Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: 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} Jul 05 12:29:28 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: No code Jul 05 12:29:28 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:28 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:28 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:28 volumio volumio[3039]: info: ------------------------------ 168ms Jul 05 12:29:28 volumio volumio[3039]: info: ------------------------------ 167ms Jul 05 12:29:28 volumio volumio[3039]: info: ------------------------------ 166ms Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:28 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:28 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:28 volumio volumio[3039]: info: Jul 05 12:29:28 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:28 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:29 volumio volumio[3039]: error: updateQueue error: null Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:29 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 181ms Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 175 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand add "USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3" took 175 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 18ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 16ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 15ms Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:29:29 volumio volumio[3039]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 215ms Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:29 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:29 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:29 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 60ms Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand play took 42 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 39ms Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 38ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 36ms Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 22 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 20 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 17 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 14 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 11 milliseconds Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: Jul 05 12:29:29 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 29 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 26 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 26 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 20 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 18 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand status took 10 milliseconds Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:29 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:29 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:29 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":411,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:29 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 147ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 240ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 232ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 230ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 228ms Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 183 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 182 milliseconds Jul 05 12:29:29 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 183 milliseconds Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:29 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:29 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:29 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:29 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:29 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:29 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 326ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 323ms Jul 05 12:29:29 volumio volumio[3039]: info: ------------------------------ 322ms Jul 05 12:29:29 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::volumioPlay Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::play index 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::stop Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::stPlaybackTimer Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::updateTrackBlock Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrackBlock Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::serviceStop Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::serviceStop Jul 05 12:29:30 volumio volumio[3039]: info: ControllerMpd::stop Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:30 volumio volumio[3039]: info: sendMpdCommand stop took 18 milliseconds Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::play index undefined Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::clearAddPlayTracks USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3 Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:30 volumio volumio[3039]: info: Jul 05 12:29:30 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:30 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:30 volumio volumio[3039]: info: sendMpdCommand stop took 3 milliseconds Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:29:30 volumio volumio[3039]: info: Jul 05 12:29:30 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:30 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:30 volumio volumio[3039]: info: Jul 05 12:29:30 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:30 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:30 volumio volumio[3039]: info: Jul 05 12:29:30 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:30 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:30 volumio volumio[3039]: info: Jul 05 12:29:30 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:30 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:30 volumio volumio[3039]: info: sendMpdCommand status took 14 milliseconds Jul 05 12:29:30 volumio volumio[3039]: info: sendMpdCommand clear took 13 milliseconds Jul 05 12:29:30 volumio volumio[3039]: info: sendMpdCommand status took 11 milliseconds Jul 05 12:29:30 volumio volumio[3039]: info: sendMpdCommand status took 8 milliseconds Jul 05 12:29:30 volumio volumio[3039]: info: sendMpdCommand status took 6 milliseconds Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand add "USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3" Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:30 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:30 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: 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} Jul 05 12:29:30 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:30 volumio volumio[3039]: info: No code Jul 05 12:29:30 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:30 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:30 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: 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} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: No code Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: 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} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: No code Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 158ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 158ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 157ms Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:31 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:31 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:31 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:31 volumio volumio[3039]: error: updateQueue error: null Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:31 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 174ms Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 170 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand add "USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3" took 169 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 15ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 12ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 11ms Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:29:31 volumio volumio[3039]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 196ms Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:31 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:31 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:31 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 55ms Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand play took 49 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 48ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 48ms Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 48ms Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 19 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 15 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 12 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 9 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 6 milliseconds Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: Jul 05 12:29:31 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 14 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 12 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand status took 8 milliseconds Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:31 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:31 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:31 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:31 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 138ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 233ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 224ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 223ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 221ms Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 186 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 186 milliseconds Jul 05 12:29:31 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 186 milliseconds Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:31 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:31 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":333,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"凉凉","artist":"杨宗纬&张碧晨","album":"三生三世十里桃花 电视剧原声专辑","uri":"USB/469A-F83B/song/杨宗纬&张碧晨-凉凉.mp3","trackType":"mp3"} Jul 05 12:29:31 volumio volumio[3039]: verbose: CURRENT POSITION 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:31 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:31 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:31 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 286ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 284ms Jul 05 12:29:31 volumio volumio[3039]: info: ------------------------------ 282ms Jul 05 12:29:33 volumio kernel: hwmon hwmon1: Voltage normalised Jul 05 12:29:39 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 05 12:29:39 volumio volumio[3039]: info: CoreCommandRouter::volumioPlay Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::play index 20 Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::stop Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::stPlaybackTimer Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::updateTrackBlock Jul 05 12:29:39 volumio volumio[3039]: info: CorePlayQueue::getTrackBlock Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:39 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:39 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:39 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::serviceStop Jul 05 12:29:39 volumio volumio[3039]: info: CorePlayQueue::getTrack 16 Jul 05 12:29:39 volumio volumio[3039]: info: CoreCommandRouter::serviceStop Jul 05 12:29:39 volumio volumio[3039]: info: ControllerMpd::stop Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:39 volumio volumio[3039]: info: sendMpdCommand stop took 22 milliseconds Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::play index undefined Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:39 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:29:39 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::clearAddPlayTracks USB/469A-F83B/song/半吨兄弟-丫头.mp3 Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:39 volumio volumio[3039]: info: Jul 05 12:29:39 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:39 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:39 volumio volumio[3039]: info: sendMpdCommand stop took 4 milliseconds Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:29:39 volumio volumio[3039]: info: Jul 05 12:29:39 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:39 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:39 volumio volumio[3039]: info: Jul 05 12:29:39 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:39 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:39 volumio volumio[3039]: info: Jul 05 12:29:39 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:39 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:39 volumio volumio[3039]: info: Jul 05 12:29:39 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:39 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:39 volumio volumio[3039]: info: sendMpdCommand status took 13 milliseconds Jul 05 12:29:39 volumio volumio[3039]: info: sendMpdCommand clear took 13 milliseconds Jul 05 12:29:39 volumio volumio[3039]: info: sendMpdCommand status took 11 milliseconds Jul 05 12:29:39 volumio volumio[3039]: info: sendMpdCommand status took 8 milliseconds Jul 05 12:29:39 volumio volumio[3039]: info: sendMpdCommand status took 6 milliseconds Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand add "USB/469A-F83B/song/半吨兄弟-丫头.mp3" Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:39 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:39 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:39 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:39 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:39 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:39 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:39 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: 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} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: No code Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: 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} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: No code Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: 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} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService stop Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: No code Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 157ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 157ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 156ms Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:40 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:40 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:40 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:40 volumio volumio[3039]: error: updateQueue error: null Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:40 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 167ms Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 163 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand add "USB/469A-F83B/song/半吨兄弟-丫头.mp3" took 162 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 15ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 12ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 10ms Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:29:40 volumio volumio[3039]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 188ms Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:40 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:40 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:40 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 45ms Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand play took 39 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 37ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 35ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 33ms Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 14 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 14 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 11 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 9 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 6 milliseconds Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: Jul 05 12:29:40 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 19 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 18 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 13 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 11 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand status took 9 milliseconds Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:40 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:40 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:40 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:40 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 116ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 213ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 209ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 207ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 206ms Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 168 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 168 milliseconds Jul 05 12:29:40 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 167 milliseconds Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:40 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:40 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":290,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"丫头","artist":"半吨兄弟","album":"丫头","uri":"USB/469A-F83B/song/半吨兄弟-丫头.mp3","trackType":"mp3"} Jul 05 12:29:40 volumio volumio[3039]: verbose: CURRENT POSITION 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:40 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:40 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:40 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 329ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 328ms Jul 05 12:29:40 volumio volumio[3039]: info: ------------------------------ 327ms Jul 05 12:29:42 volumio volumio[3039]: info: CoreCommandRouter::volumioPlay Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::play index 22 Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::stop Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::stPlaybackTimer Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::updateTrackBlock Jul 05 12:29:42 volumio volumio[3039]: info: CorePlayQueue::getTrackBlock Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:42 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:42 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:42 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::serviceStop Jul 05 12:29:42 volumio volumio[3039]: info: CorePlayQueue::getTrack 20 Jul 05 12:29:42 volumio volumio[3039]: info: CoreCommandRouter::serviceStop Jul 05 12:29:42 volumio volumio[3039]: info: ControllerMpd::stop Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand stop took 22 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::play index undefined Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 05 12:29:42 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:42 volumio volumio[3039]: info: CoreStateMachine::startPlaybackTimer Jul 05 12:29:42 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::clearAddPlayTracks USB/469A-F83B/song/陶喆-爱，很简单.mp3 Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand stop Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:42 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:42 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:42 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:42 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand stop took 11 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand status took 10 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand status took 8 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand status took 6 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand status took 3 milliseconds Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand clear Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:42 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand clear took 4 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 4 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 12:29:42 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 5 milliseconds Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand add "USB/469A-F83B/song/陶喆-爱，很简单.mp3" Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:42 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:42 volumio volumio[3039]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:29:42 volumio volumio[3039]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:29:42 volumio volumio[3039]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:29:42 volumio volumio[3039]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 05 12:29:42 volumio volumio[3039]: info: ------------------------------ 25ms Jul 05 12:29:42 volumio volumio[3039]: info: ------------------------------ 23ms Jul 05 12:29:42 volumio volumio[3039]: info: ------------------------------ 21ms Jul 05 12:29:42 volumio volumio[3039]: info: ------------------------------ 18ms Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:42 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:42 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:42 volumio volumio[3039]: info: Jul 05 12:29:42 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:42 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:43 volumio volumio[3039]: error: updateQueue error: null Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:43 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 22ms Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand add "USB/469A-F83B/song/陶喆-爱，很简单.mp3" took 18 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 12ms Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand play Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:43 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 15ms Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 9ms Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 6ms Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand play took 4 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:43 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces system playlist update Jul 05 12:29:43 volumio volumio[3039]: info: Ignoring MPD Status Update Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 30ms Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand status took 28 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand status took 27 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 27ms Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 25ms Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:43 volumio volumio[3039]: info: Jul 05 12:29:43 volumio volumio[3039]: ---------------------------- MPD announces state update: player Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::getState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand status Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand status took 36 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 32 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 31 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand status took 26 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand status took 17 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand status took 12 milliseconds Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseState Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱，很简单","artist":"陶喆","album":"乐之路","uri":"USB/469A-F83B/song/陶喆-爱，很简单.mp3","trackType":"mp3"} Jul 05 12:29:43 volumio volumio[3039]: verbose: CURRENT POSITION 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus stop Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱，很简单","artist":"陶喆","album":"乐之路","uri":"USB/469A-F83B/song/陶喆-爱，很简单.mp3","trackType":"mp3"} Jul 05 12:29:43 volumio volumio[3039]: verbose: CURRENT POSITION 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:43 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 107ms Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 133ms Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 61 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 58 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 56 milliseconds Jul 05 12:29:43 volumio volumio[3039]: info: sendMpdCommand playlistinfo took 56 milliseconds Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:43 volumio volumio[3039]: verbose: ControllerMpd::parseTrackInfo Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"爱，很简单","artist":"陶喆","album":"乐之路","uri":"USB/469A-F83B/song/陶喆-爱，很简单.mp3","trackType":"mp3"} Jul 05 12:29:43 volumio volumio[3039]: verbose: CURRENT POSITION 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:43 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":331,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"爱，很简单","artist":"陶喆","album":"乐之路","uri":"USB/469A-F83B/song/陶喆-爱，很简单.mp3","trackType":"mp3"} Jul 05 12:29:43 volumio volumio[3039]: verbose: CURRENT POSITION 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:43 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"爱，很简单","artist":"陶喆","album":"乐之路","uri":"USB/469A-F83B/song/陶喆-爱，很简单.mp3","trackType":"mp3"} Jul 05 12:29:43 volumio volumio[3039]: verbose: CURRENT POSITION 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:43 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: ControllerMpd::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::servicePushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":270,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"爱，很简单","artist":"陶喆","album":"乐之路","uri":"USB/469A-F83B/song/陶喆-爱，很简单.mp3","trackType":"mp3"} Jul 05 12:29:43 volumio volumio[3039]: verbose: CURRENT POSITION 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState stateService play Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::syncState currentStatus play Jul 05 12:29:43 volumio volumio[3039]: info: Received an update from plugin. extracting info from payload Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: CoreStateMachine::pushState Jul 05 12:29:43 volumio volumio[3039]: info: CorePlayQueue::getTrack 22 Jul 05 12:29:43 volumio volumio[3039]: info: CoreCommandRouter::volumioPushState Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 256ms Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 243ms Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 239ms Jul 05 12:29:43 volumio volumio[3039]: info: ------------------------------ 230ms Jul 05 12:29:54 volumio kernel: hwmon hwmon1: Voltage normalised Jul 05 12:29:58 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 05 12:30:04 volumio kernel: hwmon hwmon1: Voltage normalised Jul 05 12:30:08 volumio kernel: hwmon hwmon1: Undervoltage detected! Jul 05 12:30:13 volumio volumio[3039]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 12:30:13 volumio volumio[3039]: Error: connect ETIMEDOUT 108.160.166.57:443 Jul 05 12:30:13 volumio volumio[3039]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jul 05 12:30:13 volumio volumio[3039]: errno: -110, Jul 05 12:30:13 volumio volumio[3039]: code: 'ETIMEDOUT', Jul 05 12:30:13 volumio volumio[3039]: syscall: 'connect', Jul 05 12:30:13 volumio volumio[3039]: address: '108.160.166.57', Jul 05 12:30:13 volumio volumio[3039]: port: 443 Jul 05 12:30:13 volumio volumio[3039]: } Jul 05 12:30:13 volumio volumio[3039]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 05 12:30:14 volumio sudo[4315]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-07-05 12:29 Jul 05 12:30:14 volumio sudo[4315]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"