-- Logs begin at Thu 2019-02-14 18:11:59 CST, end at Tue 2025-12-30 18:11:38 CST. -- Dec 30 18:10:27 volumio volumio[827]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 30 18:10:27 volumio volumio[827]: info: Retrying Login Due to Network Error Dec 30 18:10:37 volumio volumio[827]: info: MyVolumio login type: Token Dec 30 18:10:49 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 18:10:49 volumio volumio[827]: info: CURURI: music-library Dec 30 18:10:49 volumio volumio[827]: info: Preload queue cleared Dec 30 18:10:50 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 18:10:50 volumio volumio[827]: info: CURURI: music-library/USB Dec 30 18:10:50 volumio volumio[827]: info: Preload queue cleared Dec 30 18:10:51 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 30 18:10:51 volumio volumio[827]: info: CURURI: music-library/USB/1088-DD6B Dec 30 18:10:51 volumio volumio[827]: info: Preload queue cleared Dec 30 18:10:55 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Dec 30 18:10:55 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Dec 30 18:11:03 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:04 volumio sudo[1644]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Dec 30 18:11:04 volumio sudo[1644]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 18:11:04 volumio sudo[1644]: pam_unix(sudo:session): session closed for user root Dec 30 18:11:04 volumio sudo[1646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Dec 30 18:11:04 volumio sudo[1646]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 30 18:11:04 volumio sudo[1646]: pam_unix(sudo:session): session closed for user root Dec 30 18:11:04 volumio volumio[827]: verbose: New Socket.io Connection to 192.168.1.9 from 192.168.1.60 UA: okhttp/4.9.2 Total Clients: 5 Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::volumioGetVisibleSources Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::volumioGetState Dec 30 18:11:04 volumio volumio[827]: info: CorePlayQueue::getTrack 4 Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Dec 30 18:11:04 volumio volumio[827]: info: Received Get System Info Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 18:11:04 volumio volumio[827]: info: Discovery: Getting this device information Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::volumioGetState Dec 30 18:11:04 volumio volumio[827]: info: CorePlayQueue::getTrack 4 Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::volumioGetState Dec 30 18:11:04 volumio volumio[827]: info: CorePlayQueue::getTrack 4 Dec 30 18:11:04 volumio volumio[827]: info: Listing playlists Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Dec 30 18:11:04 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:04 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Dec 30 18:11:05 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 30 18:11:06 volumio volumio[827]: info: Received Get System Info Dec 30 18:11:06 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Dec 30 18:11:06 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Dec 30 18:11:06 volumio volumio[827]: info: Discovery: Getting this device information Dec 30 18:11:06 volumio volumio[827]: info: CoreCommandRouter::volumioGetState Dec 30 18:11:06 volumio volumio[827]: info: CorePlayQueue::getTrack 4 Dec 30 18:11:06 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 30 18:11:07 volumio volumio[827]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Dec 30 18:11:07 volumio volumio[827]: info: Retrying Login Due to Network Error Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioNext Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::next Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::stPlaybackTimer Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 4 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::serviceStop Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 4 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::serviceStop Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::stop Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand stop took 14 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::play index undefined Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::startPlaybackTimer Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::clearAddPlayTracks USB/1088-DD6B/回到你身边-刘德华.mp3 Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 5 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand stop took 3 milliseconds Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:11 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand clear took 7 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 4 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 4 milliseconds Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand add "USB/1088-DD6B/回到你身边-刘德华.mp3" Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: 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":"S.H.E","album":null,"uri":"USB/1088-DD6B/半糖主义-S.H.E.mp3","trackType":"mp3"} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: No code Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: 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} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: No code Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: 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} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: No code Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 128ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 119ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 119ms Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:11 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:11 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:11 volumio volumio[827]: error: updateQueue error: null Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:11 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 124ms Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand add "USB/1088-DD6B/回到你身边-刘德华.mp3" took 121 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 7ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 5ms Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand play Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:11 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:11 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 48ms Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand play took 45 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 45ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 43ms Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 27 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 24 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 24 milliseconds Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: Dec 30 18:11:11 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 35 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand playlistinfo took 33 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand playlistinfo took 33 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand playlistinfo took 32 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 30 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand status took 28 milliseconds Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"回到你身边-刘德华.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/回到你身边-刘德华.mp3","trackType":"mp3"} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"回到你身边-刘德华.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/回到你身边-刘德华.mp3","trackType":"mp3"} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:11 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"回到你身边-刘德华.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/回到你身边-刘德华.mp3","trackType":"mp3"} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:11 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 102ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 134ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 133ms Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand playlistinfo took 78 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand playlistinfo took 76 milliseconds Dec 30 18:11:11 volumio volumio[827]: info: sendMpdCommand playlistinfo took 77 milliseconds Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:11 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":240,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"回到你身边-刘德华.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/回到你身边-刘德华.mp3","trackType":"mp3"} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:11 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":297,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"回到你身边-刘德华.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/回到你身边-刘德华.mp3","trackType":"mp3"} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:11 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":332,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"回到你身边-刘德华.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/回到你身边-刘德华.mp3","trackType":"mp3"} Dec 30 18:11:11 volumio volumio[827]: verbose: CURRENT POSITION 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:11 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:11 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:11 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 201ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 195ms Dec 30 18:11:11 volumio volumio[827]: info: ------------------------------ 194ms Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::volumioNext Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::next Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::stPlaybackTimer Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::serviceStop Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 5 Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::serviceStop Dec 30 18:11:12 volumio volumio[827]: info: ControllerMpd::stop Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:12 volumio volumio[827]: info: Dec 30 18:11:12 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:12 volumio volumio[827]: info: sendMpdCommand stop took 12 milliseconds Dec 30 18:11:12 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::play index undefined Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::startPlaybackTimer Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::clearAddPlayTracks USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3 Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:12 volumio volumio[827]: info: sendMpdCommand status took 9 milliseconds Dec 30 18:11:12 volumio volumio[827]: info: sendMpdCommand stop took 3 milliseconds Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 18:11:12 volumio volumio[827]: info: Dec 30 18:11:12 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:12 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:12 volumio volumio[827]: info: Dec 30 18:11:12 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:12 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:12 volumio volumio[827]: info: Dec 30 18:11:12 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:12 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:12 volumio volumio[827]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 30 18:11:12 volumio volumio[827]: info: sendMpdCommand clear took 7 milliseconds Dec 30 18:11:12 volumio volumio[827]: info: sendMpdCommand status took 5 milliseconds Dec 30 18:11:12 volumio volumio[827]: info: sendMpdCommand status took 4 milliseconds Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand add "USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3" Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:12 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:12 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: 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":"回到你身边-刘德华.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/回到你身边-刘德华.mp3","trackType":"mp3"} Dec 30 18:11:12 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:12 volumio volumio[827]: info: No code Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:12 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: 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} Dec 30 18:11:12 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:12 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:12 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:12 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: No code Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: 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} Dec 30 18:11:13 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: No code Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 171ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 159ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 159ms Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:13 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:13 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:13 volumio volumio[827]: error: updateQueue error: null Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:13 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 167ms Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand add "USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3" took 163 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 10ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 8ms Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand play Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:13 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:13 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 67ms Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand play took 65 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 64ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 65ms Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand status took 11 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand status took 10 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand status took 8 milliseconds Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:13 volumio volumio[827]: info: Dec 30 18:11:13 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand status took 25 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand playlistinfo took 21 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand status took 19 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand status took 15 milliseconds Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":137,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"很受伤-任贤齐#9KNS.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3","trackType":"mp3"} Dec 30 18:11:13 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":160,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"很受伤-任贤齐#9KNS.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3","trackType":"mp3"} Dec 30 18:11:13 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:13 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":183,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"很受伤-任贤齐#9KNS.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3","trackType":"mp3"} Dec 30 18:11:13 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:13 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 80ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 113ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 113ms Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand playlistinfo took 82 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand playlistinfo took 80 milliseconds Dec 30 18:11:13 volumio volumio[827]: info: sendMpdCommand playlistinfo took 79 milliseconds Dec 30 18:11:13 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":263,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"很受伤-任贤齐#9KNS.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3","trackType":"mp3"} Dec 30 18:11:13 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:13 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":354,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"很受伤-任贤齐#9KNS.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3","trackType":"mp3"} Dec 30 18:11:13 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:13 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":389,"duration":273,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"很受伤-任贤齐#9KNS.mp3","artist":null,"album":null,"uri":"USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3","trackType":"mp3"} Dec 30 18:11:13 volumio volumio[827]: verbose: CURRENT POSITION 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:13 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:13 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:13 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 190ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 182ms Dec 30 18:11:13 volumio volumio[827]: info: ------------------------------ 181ms Dec 30 18:11:15 volumio volumio[827]: info: CoreCommandRouter::volumioGetQueue Dec 30 18:11:15 volumio volumio[827]: info: CoreStateMachine::getQueue Dec 30 18:11:15 volumio volumio[827]: info: CorePlayQueue::getQueue Dec 30 18:11:17 volumio volumio[827]: info: MyVolumio login type: Token Dec 30 18:11:26 volumio volumio[827]: info: Preload queue cleared Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::ClearQueue Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::stPlaybackTimer Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::serviceStop Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 6 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::serviceStop Dec 30 18:11:26 volumio volumio[827]: info: ControllerMpd::stop Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::clearPlayQueue Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::saveQueue Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushQueue Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::addQueueItems Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::addQueueItems Dec 30 18:11:26 volumio volumio[827]: info: Preload queue cleared Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/Ring Ring Ring-S.H.E.320.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/Ring Ring Ring-S.H.E.320.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/一路生花.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/一路生花.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/最后的战役-周杰伦.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/最后的战役-周杰伦.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/最熟悉的陌生人-萧亚轩.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/最熟悉的陌生人-萧亚轩.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/半糖主义-S.H.E.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/半糖主义-S.H.E.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/回到你身边-刘德华.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/回到你身边-刘德华.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/恋人未满-S.H.E.320.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/恋人未满-S.H.E.320.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/春庭雪 DJ.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/春庭雪 DJ.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/木鱼与金鱼-刘德华.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/木鱼与金鱼-刘德华.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/爱在西元前.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/爱在西元前.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/给爱丽丝-陈奕迅.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/给爱丽丝-陈奕迅.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花田错-王力宏.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花田错-王力宏.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花都开好了-S.H.E.320.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花都开好了-S.H.E.320.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花香-许绍洋.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花香-许绍洋.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/触电-S.H.E.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/触电-S.H.E.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/辞九门回忆（Prog House DJ普先森2k24 Remix）.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/辞九门回忆（Prog House DJ普先森2k24 Remix）.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/难却dj.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/难却dj.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/青丝- DJ.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/青丝- DJ.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/黑蝙蝠中队-刘德华.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/黑蝙蝠中队-刘德华.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/伤痕-林忆莲.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/伤痕-林忆莲.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/Believe-杜德伟.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/Believe-杜德伟.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/醉清风.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/醉清风.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/梦醒时分.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/梦醒时分.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/电台情歌-莫文蔚.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/电台情歌-莫文蔚.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/左右为难.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/左右为难.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/心中的日月.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/心中的日月.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/心太软-任贤齐.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/心太软-任贤齐.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/你爱我像谁-张卫健.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/你爱我像谁-张卫健.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/我不配.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/我不配.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/探故知DJ.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/探故知DJ.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/火力全开-王力宏.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/火力全开-王力宏.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/第一次爱的人-王心凌.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/第一次爱的人-王心凌.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/我是一只鱼-任贤齐.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/我是一只鱼-任贤齐.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/苦恋-张学友.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/苦恋-张学友.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/玫瑰花的葬礼-许嵩.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/玫瑰花的葬礼-许嵩.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/难得有情人-关淑怡.mp3 Dec 30 18:11:26 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/难得有情人-关淑怡.mp3 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushQueue Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::saveQueue Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPlay Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::play index 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::play index undefined Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::startPlaybackTimer Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::clearAddPlayTracks USB/1088-DD6B/花都开好了-S.H.E.320.mp3 Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:26 volumio volumio[827]: info: Dec 30 18:11:26 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:26 volumio volumio[827]: info: sendMpdCommand stop took 60 milliseconds Dec 30 18:11:26 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:26 volumio volumio[827]: info: sendMpdCommand stop took 11 milliseconds Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 18:11:26 volumio volumio[827]: info: Dec 30 18:11:26 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:26 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:26 volumio volumio[827]: info: Dec 30 18:11:26 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:26 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:26 volumio volumio[827]: info: Dec 30 18:11:26 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:26 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:26 volumio volumio[827]: info: sendMpdCommand status took 10 milliseconds Dec 30 18:11:26 volumio volumio[827]: info: sendMpdCommand clear took 10 milliseconds Dec 30 18:11:26 volumio volumio[827]: info: sendMpdCommand status took 7 milliseconds Dec 30 18:11:26 volumio volumio[827]: info: sendMpdCommand status took 7 milliseconds Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand add "USB/1088-DD6B/花都开好了-S.H.E.320.mp3" Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:26 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:26 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: 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} Dec 30 18:11:26 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:26 volumio volumio[827]: info: No code Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:26 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: 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} Dec 30 18:11:26 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:26 volumio volumio[827]: info: No code Dec 30 18:11:26 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:26 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:26 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 110ms Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 110ms Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:27 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:27 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:27 volumio volumio[827]: error: updateQueue error: null Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:27 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 113ms Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand playlistinfo took 111 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand add "USB/1088-DD6B/花都开好了-S.H.E.320.mp3" took 111 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 9ms Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 7ms Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand play Dec 30 18:11:27 volumio volumio[827]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 128ms Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:27 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:27 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 31ms Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand play took 28 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 26ms Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 25ms Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:27 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand status took 14 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand status took 12 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand status took 9 milliseconds Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:27 volumio volumio[827]: info: Dec 30 18:11:27 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand status took 29 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand playlistinfo took 25 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand playlistinfo took 24 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand status took 21 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand status took 19 milliseconds Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"»¨¶¼¿ªºÃÁË","artist":"S.H.E","album":null,"uri":"USB/1088-DD6B/花都开好了-S.H.E.320.mp3","trackType":"mp3"} Dec 30 18:11:27 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":22,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨¶¼¿ªºÃÁË","artist":"S.H.E","album":null,"uri":"USB/1088-DD6B/花都开好了-S.H.E.320.mp3","trackType":"mp3"} Dec 30 18:11:27 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:27 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":57,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨¶¼¿ªºÃÁË","artist":"S.H.E","album":null,"uri":"USB/1088-DD6B/花都开好了-S.H.E.320.mp3","trackType":"mp3"} Dec 30 18:11:27 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:27 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 104ms Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 138ms Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 135ms Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand playlistinfo took 95 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand playlistinfo took 92 milliseconds Dec 30 18:11:27 volumio volumio[827]: info: sendMpdCommand playlistinfo took 90 milliseconds Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:27 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":160,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨¶¼¿ªºÃÁË","artist":"S.H.E","album":null,"uri":"USB/1088-DD6B/花都开好了-S.H.E.320.mp3","trackType":"mp3"} Dec 30 18:11:27 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:27 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":263,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨¶¼¿ªºÃÁË","artist":"S.H.E","album":null,"uri":"USB/1088-DD6B/花都开好了-S.H.E.320.mp3","trackType":"mp3"} Dec 30 18:11:27 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:27 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":297,"duration":221,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨¶¼¿ªºÃÁË","artist":"S.H.E","album":null,"uri":"USB/1088-DD6B/花都开好了-S.H.E.320.mp3","trackType":"mp3"} Dec 30 18:11:27 volumio volumio[827]: verbose: CURRENT POSITION 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:27 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:27 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:27 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 219ms Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 207ms Dec 30 18:11:27 volumio volumio[827]: info: ------------------------------ 205ms Dec 30 18:11:27 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:27 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:27 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:27 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:27 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/S.H.E/591e2a7f-590c-4d05-a28d-d21f0d19933f.jpg' Dec 30 18:11:28 volumio volumio[827]: info: Preload queue cleared Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::ClearQueue Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::stPlaybackTimer Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::serviceStop Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 13 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::serviceStop Dec 30 18:11:28 volumio volumio[827]: info: ControllerMpd::stop Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::clearPlayQueue Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::saveQueue Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushQueue Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::addQueueItems Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::addQueueItems Dec 30 18:11:28 volumio volumio[827]: info: Preload queue cleared Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/Ring Ring Ring-S.H.E.320.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/Ring Ring Ring-S.H.E.320.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/一路生花.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/一路生花.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/最后的战役-周杰伦.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/最后的战役-周杰伦.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/最熟悉的陌生人-萧亚轩.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/最熟悉的陌生人-萧亚轩.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/半糖主义-S.H.E.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/半糖主义-S.H.E.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/回到你身边-刘德华.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/回到你身边-刘德华.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/恋人未满-S.H.E.320.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/恋人未满-S.H.E.320.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/春庭雪 DJ.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/春庭雪 DJ.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/木鱼与金鱼-刘德华.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/木鱼与金鱼-刘德华.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/爱在西元前.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/爱在西元前.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/给爱丽丝-陈奕迅.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/给爱丽丝-陈奕迅.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花田错-王力宏.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花田错-王力宏.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花都开好了-S.H.E.320.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花都开好了-S.H.E.320.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花香-许绍洋.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花香-许绍洋.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/触电-S.H.E.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/触电-S.H.E.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/辞九门回忆（Prog House DJ普先森2k24 Remix）.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/辞九门回忆（Prog House DJ普先森2k24 Remix）.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/难却dj.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/难却dj.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/青丝- DJ.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/青丝- DJ.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/黑蝙蝠中队-刘德华.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/黑蝙蝠中队-刘德华.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/伤痕-林忆莲.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/伤痕-林忆莲.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/Believe-杜德伟.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/Believe-杜德伟.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/醉清风.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/醉清风.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/梦醒时分.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/梦醒时分.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/电台情歌-莫文蔚.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/电台情歌-莫文蔚.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/左右为难.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/左右为难.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/心中的日月.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/心中的日月.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/心太软-任贤齐.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/心太软-任贤齐.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/你爱我像谁-张卫健.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/你爱我像谁-张卫健.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/我不配.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/我不配.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/探故知DJ.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/探故知DJ.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/火力全开-王力宏.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/火力全开-王力宏.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/第一次爱的人-王心凌.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/第一次爱的人-王心凌.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/我是一只鱼-任贤齐.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/我是一只鱼-任贤齐.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/苦恋-张学友.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/苦恋-张学友.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/玫瑰花的葬礼-许嵩.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/玫瑰花的葬礼-许嵩.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/难得有情人-关淑怡.mp3 Dec 30 18:11:28 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/难得有情人-关淑怡.mp3 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushQueue Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::saveQueue Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPlay Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::play index 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::play index undefined Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::startPlaybackTimer Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::clearAddPlayTracks USB/1088-DD6B/花田错-王力宏.mp3 Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:28 volumio volumio[827]: info: Dec 30 18:11:28 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:28 volumio volumio[827]: info: sendMpdCommand stop took 67 milliseconds Dec 30 18:11:28 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:28 volumio volumio[827]: info: sendMpdCommand stop took 18 milliseconds Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 18:11:28 volumio volumio[827]: info: Dec 30 18:11:28 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:28 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:28 volumio volumio[827]: info: Dec 30 18:11:28 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:28 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:28 volumio volumio[827]: info: Dec 30 18:11:28 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:28 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:28 volumio volumio[827]: info: sendMpdCommand status took 16 milliseconds Dec 30 18:11:28 volumio volumio[827]: info: sendMpdCommand clear took 15 milliseconds Dec 30 18:11:28 volumio volumio[827]: info: sendMpdCommand status took 13 milliseconds Dec 30 18:11:28 volumio volumio[827]: info: sendMpdCommand status took 10 milliseconds Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand add "USB/1088-DD6B/花田错-王力宏.mp3" Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:28 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:28 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: 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} Dec 30 18:11:28 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:28 volumio volumio[827]: info: No code Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:28 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: 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} Dec 30 18:11:28 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:28 volumio volumio[827]: info: No code Dec 30 18:11:28 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:28 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:28 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 105ms Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 103ms Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:29 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:29 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:29 volumio volumio[827]: error: updateQueue error: null Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:29 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 109ms Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand playlistinfo took 102 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand add "USB/1088-DD6B/花田错-王力宏.mp3" took 102 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 12ms Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 10ms Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand play Dec 30 18:11:29 volumio volumio[827]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 130ms Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:29 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:29 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 39ms Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand play took 36 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 33ms Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 31ms Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:29 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C3%81%C2%A6%C2%BA%C3%AA/848759df-e6cb-42ab-b7f4-e5e73c3910f7.jpg' Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand status took 28 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand status took 27 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand status took 26 milliseconds Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:29 volumio volumio[827]: info: Dec 30 18:11:29 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:29 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C3%81%C2%A6%C2%BA%C3%AA/848759df-e6cb-42ab-b7f4-e5e73c3910f7.jpg' Dec 30 18:11:29 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C3%81%C2%A6%C2%BA%C3%AA/848759df-e6cb-42ab-b7f4-e5e73c3910f7.jpg' Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand status took 18 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand playlistinfo took 16 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand playlistinfo took 15 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand status took 15 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand status took 14 milliseconds Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"»¨Ìï´í","artist":"ÍõÁ¦ºê","album":null,"uri":"USB/1088-DD6B/花田错-王力宏.mp3","trackType":"mp3"} Dec 30 18:11:29 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"»¨Ìï´í","artist":"ÍõÁ¦ºê","album":null,"uri":"USB/1088-DD6B/花田错-王力宏.mp3","trackType":"mp3"} Dec 30 18:11:29 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:29 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"»¨Ìï´í","artist":"ÍõÁ¦ºê","album":null,"uri":"USB/1088-DD6B/花田错-王力宏.mp3","trackType":"mp3"} Dec 30 18:11:29 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:29 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 80ms Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 114ms Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 114ms Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand playlistinfo took 79 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand playlistinfo took 77 milliseconds Dec 30 18:11:29 volumio volumio[827]: info: sendMpdCommand playlistinfo took 78 milliseconds Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:29 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":171,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨Ìï´í","artist":"ÍõÁ¦ºê","album":null,"uri":"USB/1088-DD6B/花田错-王力宏.mp3","trackType":"mp3"} Dec 30 18:11:29 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:29 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":229,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨Ìï´í","artist":"ÍõÁ¦ºê","album":null,"uri":"USB/1088-DD6B/花田错-王力宏.mp3","trackType":"mp3"} Dec 30 18:11:29 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:29 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":286,"duration":228,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"»¨Ìï´í","artist":"ÍõÁ¦ºê","album":null,"uri":"USB/1088-DD6B/花田错-王力宏.mp3","trackType":"mp3"} Dec 30 18:11:29 volumio volumio[827]: verbose: CURRENT POSITION 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:29 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:29 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:29 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 175ms Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 170ms Dec 30 18:11:29 volumio volumio[827]: info: ------------------------------ 169ms Dec 30 18:11:29 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C3%81%C2%A6%C2%BA%C3%AA/848759df-e6cb-42ab-b7f4-e5e73c3910f7.jpg' Dec 30 18:11:29 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C3%81%C2%A6%C2%BA%C3%AA/848759df-e6cb-42ab-b7f4-e5e73c3910f7.jpg' Dec 30 18:11:29 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C3%81%C2%A6%C2%BA%C3%AA/848759df-e6cb-42ab-b7f4-e5e73c3910f7.jpg' Dec 30 18:11:29 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%C3%8D%C3%B5%C3%81%C2%A6%C2%BA%C3%AA/848759df-e6cb-42ab-b7f4-e5e73c3910f7.jpg' Dec 30 18:11:35 volumio volumio[827]: info: Preload queue cleared Dec 30 18:11:35 volumio volumio[827]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::ClearQueue Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::stPlaybackTimer Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:35 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:35 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:35 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:35 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::serviceStop Dec 30 18:11:35 volumio volumio[827]: info: CorePlayQueue::getTrack 12 Dec 30 18:11:35 volumio volumio[827]: info: CoreCommandRouter::serviceStop Dec 30 18:11:35 volumio volumio[827]: info: ControllerMpd::stop Dec 30 18:11:35 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:35 volumio volumio[827]: info: CorePlayQueue::clearPlayQueue Dec 30 18:11:35 volumio volumio[827]: info: CorePlayQueue::saveQueue Dec 30 18:11:35 volumio volumio[827]: info: CoreCommandRouter::volumioPushQueue Dec 30 18:11:35 volumio volumio[827]: info: CoreStateMachine::addQueueItems Dec 30 18:11:35 volumio volumio[827]: info: CorePlayQueue::addQueueItems Dec 30 18:11:35 volumio volumio[827]: info: Preload queue cleared Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/Ring Ring Ring-S.H.E.320.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/Ring Ring Ring-S.H.E.320.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/一路生花.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/一路生花.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/最后的战役-周杰伦.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/最后的战役-周杰伦.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/最熟悉的陌生人-萧亚轩.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/最熟悉的陌生人-萧亚轩.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/半糖主义-S.H.E.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/半糖主义-S.H.E.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/回到你身边-刘德华.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/回到你身边-刘德华.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/很受伤-任贤齐#9KNS.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/恋人未满-S.H.E.320.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/恋人未满-S.H.E.320.mp3 Dec 30 18:11:35 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/春庭雪 DJ.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/春庭雪 DJ.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/木鱼与金鱼-刘德华.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/木鱼与金鱼-刘德华.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/爱在西元前.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/爱在西元前.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/给爱丽丝-陈奕迅.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/给爱丽丝-陈奕迅.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花田错-王力宏.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花田错-王力宏.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花都开好了-S.H.E.320.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花都开好了-S.H.E.320.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/花香-许绍洋.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/花香-许绍洋.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/触电-S.H.E.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/触电-S.H.E.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/辞九门回忆（Prog House DJ普先森2k24 Remix）.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/辞九门回忆（Prog House DJ普先森2k24 Remix）.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/难却dj.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/难却dj.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/青丝- DJ.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/青丝- DJ.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/黑蝙蝠中队-刘德华.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/黑蝙蝠中队-刘德华.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/伤痕-林忆莲.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/伤痕-林忆莲.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/Believe-杜德伟.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/Believe-杜德伟.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/醉清风.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/醉清风.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/梦醒时分.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/梦醒时分.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/电台情歌-莫文蔚.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/电台情歌-莫文蔚.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/左右为难.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/左右为难.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/心中的日月.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/心中的日月.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/心太软-任贤齐.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/心太软-任贤齐.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/你爱我像谁-张卫健.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/你爱我像谁-张卫健.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/我不配.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/我不配.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/探故知DJ.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/探故知DJ.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/火力全开-王力宏.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/火力全开-王力宏.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/第一次爱的人-王心凌.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/第一次爱的人-王心凌.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/我是一只鱼-任贤齐.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/我是一只鱼-任贤齐.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/苦恋-张学友.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/苦恋-张学友.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/玫瑰花的葬礼-许嵩.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/玫瑰花的葬礼-许嵩.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Adding Item to queue: music-library/USB/1088-DD6B/难得有情人-关淑怡.mp3 Dec 30 18:11:36 volumio volumio[827]: info: Using cached record of: music-library/USB/1088-DD6B/难得有情人-关淑怡.mp3 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushQueue Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::saveQueue Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::updateTrackBlock Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrackBlock Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPlay Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::play index 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::stop Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::play index undefined Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::startPlaybackTimer Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::clearAddPlayTracks USB/1088-DD6B/苦恋-张学友.mp3 Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand stop Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand stop took 102 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand stop took 34 milliseconds Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand clear Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:36 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 18 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand clear took 16 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 14 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 13 milliseconds Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand add "USB/1088-DD6B/苦恋-张学友.mp3" Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: 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} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: No code Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: 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} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService stop Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: No code Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 142ms Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 141ms Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:36 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:36 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:36 volumio volumio[827]: error: updateQueue error: null Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:36 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 177ms Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand playlistinfo took 173 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand add "USB/1088-DD6B/苦恋-张学友.mp3" took 173 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 47ms Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 45ms Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand play Dec 30 18:11:36 volumio volumio[827]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 202ms Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:36 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces system playlist update Dec 30 18:11:36 volumio volumio[827]: info: Ignoring MPD Status Update Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 70ms Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand play took 65 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 61ms Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 60ms Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 35 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 26 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 25 milliseconds Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: info: Dec 30 18:11:36 volumio volumio[827]: ---------------------------- MPD announces state update: player Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::getState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand status Dec 30 18:11:36 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%A5%9D%E7%A6%8F/6c07d8c1-ae3c-4764-a904-074339d4108b.jpg' Dec 30 18:11:36 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%A5%9D%E7%A6%8F/6c07d8c1-ae3c-4764-a904-074339d4108b.jpg' Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 33 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand playlistinfo took 31 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand playlistinfo took 31 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand playlistinfo took 31 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 28 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand status took 28 milliseconds Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseState Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":332,"duration":247,"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/1088-DD6B/苦恋-张学友.mp3","trackType":"mp3"} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus stop Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":332,"duration":247,"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/1088-DD6B/苦恋-张学友.mp3","trackType":"mp3"} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:36 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":343,"duration":247,"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/1088-DD6B/苦恋-张学友.mp3","trackType":"mp3"} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:36 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 101ms Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 128ms Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 127ms Dec 30 18:11:36 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%A5%9D%E7%A6%8F/6c07d8c1-ae3c-4764-a904-074339d4108b.jpg' Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand playlistinfo took 73 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand playlistinfo took 72 milliseconds Dec 30 18:11:36 volumio volumio[827]: info: sendMpdCommand playlistinfo took 71 milliseconds Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:36 volumio volumio[827]: verbose: ControllerMpd::parseTrackInfo Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":641,"duration":247,"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/1088-DD6B/苦恋-张学友.mp3","trackType":"mp3"} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:36 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":698,"duration":247,"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/1088-DD6B/苦恋-张学友.mp3","trackType":"mp3"} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:36 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: ControllerMpd::pushState Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::servicePushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: verbose: STATE SERVICE {"status":"play","position":0,"seek":698,"duration":247,"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/1088-DD6B/苦恋-张学友.mp3","trackType":"mp3"} Dec 30 18:11:36 volumio volumio[827]: verbose: CURRENT POSITION 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState stateService play Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::syncState currentStatus play Dec 30 18:11:36 volumio volumio[827]: info: Received an update from plugin. extracting info from payload Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: CoreStateMachine::pushState Dec 30 18:11:36 volumio volumio[827]: info: CorePlayQueue::getTrack 34 Dec 30 18:11:36 volumio volumio[827]: info: CoreCommandRouter::volumioPushState Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 197ms Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 191ms Dec 30 18:11:36 volumio volumio[827]: info: ------------------------------ 191ms Dec 30 18:11:36 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%A5%9D%E7%A6%8F/6c07d8c1-ae3c-4764-a904-074339d4108b.jpg' Dec 30 18:11:36 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%A5%9D%E7%A6%8F/6c07d8c1-ae3c-4764-a904-074339d4108b.jpg' Dec 30 18:11:36 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%A5%9D%E7%A6%8F/6c07d8c1-ae3c-4764-a904-074339d4108b.jpg' Dec 30 18:11:36 volumio volumio[827]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%BC%A0%E5%AD%A6%E5%8F%8B/%E7%A5%9D%E7%A6%8F/6c07d8c1-ae3c-4764-a904-074339d4108b.jpg' Dec 30 18:11:38 volumio volumio[827]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 18:11:38 volumio volumio[827]: Error: connect ETIMEDOUT 157.240.7.5:80 Dec 30 18:11:38 volumio volumio[827]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Dec 30 18:11:38 volumio volumio[827]: errno: -110, Dec 30 18:11:38 volumio volumio[827]: code: 'ETIMEDOUT', Dec 30 18:11:38 volumio volumio[827]: syscall: 'connect', Dec 30 18:11:38 volumio volumio[827]: address: '157.240.7.5', Dec 30 18:11:38 volumio volumio[827]: port: 80 Dec 30 18:11:38 volumio volumio[827]: } Dec 30 18:11:38 volumio volumio[827]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 30 18:11:38 volumio sudo[1737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-30 18:10 Dec 30 18:11:38 volumio sudo[1737]: 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="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"