-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2025-03-16 03:45:17 CST. -- Mar 16 03:44:06 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:44:06 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:44:06 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:44:06 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:44:06 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:06 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:44:09 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:44:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:44:09 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:44:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:44:36 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:44:36 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:44:36 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:44:36 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:44:36 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:36 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:44:39 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:44:39 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:44:39 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:44:39 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:39 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:44:49 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 16 03:44:49 volumio volumio[1119]: info: CURURI: music-library/USB Mar 16 03:44:49 volumio volumio[1119]: info: Preload queue cleared Mar 16 03:44:49 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 16 03:44:49 volumio volumio[1119]: info: CURURI: music-library/USB/TOSHIBA Mar 16 03:44:50 volumio volumio[1119]: info: Preload queue cleared Mar 16 03:44:54 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 16 03:44:54 volumio volumio[1119]: info: CURURI: music-library/USB/TOSHIBA/徐小凤 Mar 16 03:44:54 volumio volumio[1119]: info: Preload queue cleared Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/一臉紅霞.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/婚紗背後.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/情比雨絲.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/无奈.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/星光的背後.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/星星問.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/每一步.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/真愛又如何.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/破曉時分.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/隨想曲.wav Mar 16 03:44:54 volumio volumio[1119]: info: Preloading song: music-library/USB/TOSHIBA/徐小凤/順流逆流.wav Mar 16 03:44:54 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/一臉紅霞.wav in service mpd Mar 16 03:44:54 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E4%B8%80%E8%87%89%E7%B4%85%E9%9C%9E.wav&metadata=false Mar 16 03:44:54 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/一臉紅霞.wav Mar 16 03:44:54 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/婚紗背後.wav in service mpd Mar 16 03:44:54 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E5%A9%9A%E7%B4%97%E8%83%8C%E5%BE%8C.wav&metadata=false Mar 16 03:44:54 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/婚紗背後.wav Mar 16 03:44:54 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/情比雨絲.wav in service mpd Mar 16 03:44:54 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E6%83%85%E6%AF%94%E9%9B%A8%E7%B5%B2.wav&metadata=false Mar 16 03:44:54 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/情比雨絲.wav Mar 16 03:44:54 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/无奈.wav in service mpd Mar 16 03:44:54 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E6%97%A0%E5%A5%88.wav&metadata=false Mar 16 03:44:54 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/无奈.wav Mar 16 03:44:54 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/星光的背後.wav in service mpd Mar 16 03:44:54 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E6%98%9F%E5%85%89%E7%9A%84%E8%83%8C%E5%BE%8C.wav&metadata=false Mar 16 03:44:54 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/星光的背後.wav Mar 16 03:44:54 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/星星問.wav in service mpd Mar 16 03:44:54 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E6%98%9F%E6%98%9F%E5%95%8F.wav&metadata=false Mar 16 03:44:54 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/星星問.wav Mar 16 03:44:55 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/每一步.wav in service mpd Mar 16 03:44:55 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E6%AF%8F%E4%B8%80%E6%AD%A5.wav&metadata=false Mar 16 03:44:55 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/每一步.wav Mar 16 03:44:55 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/真愛又如何.wav in service mpd Mar 16 03:44:55 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E7%9C%9F%E6%84%9B%E5%8F%88%E5%A6%82%E4%BD%95.wav&metadata=false Mar 16 03:44:55 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/真愛又如何.wav Mar 16 03:44:55 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/破曉時分.wav in service mpd Mar 16 03:44:55 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E7%A0%B4%E6%9B%89%E6%99%82%E5%88%86.wav&metadata=false Mar 16 03:44:55 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/破曉時分.wav Mar 16 03:44:55 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/隨想曲.wav in service mpd Mar 16 03:44:55 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E9%9A%A8%E6%83%B3%E6%9B%B2.wav&metadata=false Mar 16 03:44:55 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/隨想曲.wav Mar 16 03:44:55 volumio volumio[1119]: info: Exploding uri music-library/USB/TOSHIBA/徐小凤/順流逆流.wav in service mpd Mar 16 03:44:55 volumio volumio[1119]: info: ALBUMART /albumart?cacheid=607&web=//extralarge&path=%2Fmnt%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4%2F%E9%A0%86%E6%B5%81%E9%80%86%E6%B5%81.wav&metadata=false Mar 16 03:44:55 volumio volumio[1119]: info: URI /mnt/USB/TOSHIBA/徐小凤/順流逆流.wav Mar 16 03:44:55 volumio volumio[1119]: info: Preload queue cleared Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::ClearQueue Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::stop Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::stPlaybackTimer Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::serviceStop Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 1 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::serviceStop Mar 16 03:44:55 volumio volumio[1119]: info: ControllerMpd::stop Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::clearPlayQueue Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::saveQueue Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushQueue Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::addQueueItems Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::addQueueItems Mar 16 03:44:55 volumio volumio[1119]: info: Preload queue cleared Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/一臉紅霞.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/一臉紅霞.wav Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushQueue Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::saveQueue Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPlay Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::play index 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::addQueueItems Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::addQueueItems Mar 16 03:44:55 volumio volumio[1119]: info: Preload queue cleared Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/婚紗背後.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/婚紗背後.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/情比雨絲.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/情比雨絲.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/无奈.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/无奈.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/星光的背後.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/星光的背後.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/星星問.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/星星問.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/每一步.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/每一步.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/真愛又如何.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/真愛又如何.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/破曉時分.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/破曉時分.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/隨想曲.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/隨想曲.wav Mar 16 03:44:55 volumio volumio[1119]: info: Adding Item to queue: music-library/USB/TOSHIBA/徐小凤/順流逆流.wav Mar 16 03:44:55 volumio volumio[1119]: info: Using cached record of: music-library/USB/TOSHIBA/徐小凤/順流逆流.wav Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::stop Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushQueue Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::saveQueue Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::play index undefined Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::updateTrackBlock Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrackBlock Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::clearAddPlayTracks USB/TOSHIBA/徐小凤/一臉紅霞.wav Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand stop Mar 16 03:44:55 volumio volumio[1119]: info: Mar 16 03:44:55 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:55 volumio volumio[1119]: info: sendMpdCommand stop took 38 milliseconds Mar 16 03:44:55 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:55 volumio volumio[1119]: info: sendMpdCommand stop took 7 milliseconds Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand clear Mar 16 03:44:55 volumio volumio[1119]: info: Mar 16 03:44:55 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:55 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:55 volumio volumio[1119]: info: Mar 16 03:44:55 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:55 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:55 volumio volumio[1119]: info: Mar 16 03:44:55 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Mar 16 03:44:55 volumio volumio[1119]: info: Ignoring MPD Status Update Mar 16 03:44:55 volumio volumio[1119]: info: sendMpdCommand status took 5 milliseconds Mar 16 03:44:55 volumio volumio[1119]: info: sendMpdCommand clear took 4 milliseconds Mar 16 03:44:55 volumio volumio[1119]: info: sendMpdCommand status took 3 milliseconds Mar 16 03:44:55 volumio volumio[1119]: info: sendMpdCommand status took 3 milliseconds Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand add "USB/TOSHIBA/徐小凤/一臉紅霞.wav" Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:55 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:55 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: 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} Mar 16 03:44:55 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::syncState stateService stop Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus stop Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:55 volumio volumio[1119]: info: No code Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:55 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: 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} Mar 16 03:44:55 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::syncState stateService stop Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus stop Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:55 volumio volumio[1119]: info: No code Mar 16 03:44:55 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:55 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:55 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 52ms Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 52ms Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Mar 16 03:44:56 volumio volumio[1119]: info: Ignoring MPD Status Update Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Mar 16 03:44:56 volumio volumio[1119]: info: Ignoring MPD Status Update Mar 16 03:44:56 volumio volumio[1119]: error: Upnp client error: Error: This socket has been ended by the other party Mar 16 03:44:56 volumio volumio[1119]: error: updateQueue error: null Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Mar 16 03:44:56 volumio volumio[1119]: info: Ignoring MPD Status Update Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 59ms Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 57 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand add "USB/TOSHIBA/徐小凤/一臉紅霞.wav" took 57 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 9ms Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 8ms Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand play Mar 16 03:44:56 volumio volumio[1119]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 67ms Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Mar 16 03:44:56 volumio volumio[1119]: info: Ignoring MPD Status Update Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces system playlist update Mar 16 03:44:56 volumio volumio[1119]: info: Ignoring MPD Status Update Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 16ms Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand play took 13 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 12ms Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 11ms Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand status took 23 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand status took 16 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand status took 12 milliseconds Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:56 volumio volumio[1119]: info: Mar 16 03:44:56 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand status took 28 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 20 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 18 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand status took 12 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand status took 8 milliseconds Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:44:56 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus stop Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:44:56 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:44:56 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:44:56 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:44:56 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 86ms Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 104ms Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 94ms Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 90 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 87 milliseconds Mar 16 03:44:56 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 86 milliseconds Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:44:56 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:44:56 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:44:56 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:44:56 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:44:56 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:44:56 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:44:56 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:44:56 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:44:56 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 199ms Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 182ms Mar 16 03:44:56 volumio volumio[1119]: info: ------------------------------ 179ms Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioSeek Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::seek Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: TRACKBLOCK {"uri":"mnt/USB/TOSHIBA/徐小凤/一臉紅霞.wav","service":"mpd","name":"一臉紅霞.wav","artist":"","album":"","type":"track","tracknumber":0,"albumart":"/albumart?cacheid=607&web=//extralarge&path=%2FUSB%2FTOSHIBA%2F%E5%BE%90%E5%B0%8F%E5%87%A4&metadata=false","duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","trackType":"wav","channels":2} Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::startPlaybackTimer Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: ControllerMpd::seek Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:03 volumio volumio[1119]: error: null Mar 16 03:45:03 volumio volumio[1119]: info: Mar 16 03:45:03 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:45:03 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:45:03 volumio volumio[1119]: info: Mar 16 03:45:03 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:45:03 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:45:03 volumio volumio[1119]: info: Mar 16 03:45:03 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:45:03 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:45:03 volumio volumio[1119]: info: sendMpdCommand status took 11 milliseconds Mar 16 03:45:03 volumio volumio[1119]: info: sendMpdCommand status took 8 milliseconds Mar 16 03:45:03 volumio volumio[1119]: info: sendMpdCommand status took 7 milliseconds Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:45:03 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 16 03:45:03 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 16 03:45:03 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:45:03 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:45:03 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81457,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:45:03 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:45:03 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:03 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:45:03 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:45:03 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:03 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: verbose: STATE SERVICE {"status":"play","position":0,"seek":81846,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:45:03 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::syncState stateService play Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus play Mar 16 03:45:03 volumio volumio[1119]: info: Received an update from plugin. extracting info from payload Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:03 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:03 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:03 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:03 volumio volumio[1119]: info: ------------------------------ 78ms Mar 16 03:45:03 volumio volumio[1119]: info: ------------------------------ 76ms Mar 16 03:45:03 volumio volumio[1119]: info: ------------------------------ 74ms Mar 16 03:45:06 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:45:06 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:45:06 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:45:06 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:45:06 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:06 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::volumioPause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::pause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::stPlaybackTimer Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::servicePause Mar 16 03:45:07 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::servicePause Mar 16 03:45:07 volumio volumio[1119]: info: ControllerMpd::pause Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand pause Mar 16 03:45:07 volumio volumio[1119]: info: Mar 16 03:45:07 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:45:07 volumio volumio[1119]: info: sendMpdCommand pause took 2 milliseconds Mar 16 03:45:07 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:45:07 volumio volumio[1119]: info: Mar 16 03:45:07 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:45:07 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:45:07 volumio volumio[1119]: info: Mar 16 03:45:07 volumio volumio[1119]: ---------------------------- MPD announces state update: player Mar 16 03:45:07 volumio volumio[1119]: info: ControllerMpd::getState Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand status Mar 16 03:45:07 volumio volumio[1119]: info: sendMpdCommand status took 5 milliseconds Mar 16 03:45:07 volumio volumio[1119]: info: sendMpdCommand status took 4 milliseconds Mar 16 03:45:07 volumio volumio[1119]: info: sendMpdCommand status took 1 milliseconds Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::parseState Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 16 03:45:07 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 16 03:45:07 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 16 03:45:07 volumio volumio[1119]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:45:07 volumio volumio[1119]: verbose: ControllerMpd::parseTrackInfo Mar 16 03:45:07 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:45:07 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:07 volumio volumio[1119]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85598,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:45:07 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::syncState stateService pause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus pause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:07 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::stPlaybackTimer Mar 16 03:45:07 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:45:07 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:07 volumio volumio[1119]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85598,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:45:07 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::syncState stateService pause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus pause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:07 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::stPlaybackTimer Mar 16 03:45:07 volumio volumio[1119]: info: ControllerMpd::pushState Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::servicePushState Mar 16 03:45:07 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:07 volumio volumio[1119]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":85598,"duration":252,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"一臉紅霞.wav","artist":null,"album":null,"uri":"USB/TOSHIBA/徐小凤/一臉紅霞.wav","trackType":"wav"} Mar 16 03:45:07 volumio volumio[1119]: verbose: CURRENT POSITION 0 Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::syncState stateService pause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::syncState currentStatus pause Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::pushState Mar 16 03:45:07 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:07 volumio volumio[1119]: info: CoreCommandRouter::volumioPushState Mar 16 03:45:07 volumio volumio[1119]: info: CoreStateMachine::stPlaybackTimer Mar 16 03:45:07 volumio volumio[1119]: info: ------------------------------ 32ms Mar 16 03:45:07 volumio volumio[1119]: info: ------------------------------ 31ms Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:45:09 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:45:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 03:45:09 volumio volumio[1119]: info: Discovery: Getting this device information Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::volumioGetState Mar 16 03:45:09 volumio volumio[1119]: info: CorePlayQueue::getTrack 0 Mar 16 03:45:09 volumio volumio[1119]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 03:45:16 volumio volumio[1119]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 03:45:16 volumio volumio[1119]: Error: connect ETIMEDOUT 108.160.170.45:80 Mar 16 03:45:16 volumio volumio[1119]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Mar 16 03:45:16 volumio volumio[1119]: errno: -110, Mar 16 03:45:16 volumio volumio[1119]: code: 'ETIMEDOUT', Mar 16 03:45:16 volumio volumio[1119]: syscall: 'connect', Mar 16 03:45:16 volumio volumio[1119]: address: '108.160.170.45', Mar 16 03:45:16 volumio volumio[1119]: port: 80 Mar 16 03:45:16 volumio volumio[1119]: } Mar 16 03:45:16 volumio volumio[1119]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 03:45:17 volumio sudo[3629]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 03:44 Mar 16 03:45:17 volumio sudo[3629]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:02:39 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="e62831d2665580a7904f9309b43b2eea"