Mar 26 23:13:01 volumio upmpdcli[4009]: writing RSA key Mar 26 23:13:02 volumio ntpd[873]: CLOCK: kernel reports TIME_ERROR: 0x41: Clock Unsynchronized Mar 26 23:13:04 volumio volumio[1237]: info: CoreCommandRouter::volumioGetQueue Mar 26 23:13:04 volumio volumio[1237]: info: CoreStateMachine::getQueue Mar 26 23:13:04 volumio volumio[1237]: info: CorePlayQueue::getQueue Mar 26 23:13:06 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 23:13:06 volumio volumio[1237]: info: CURURI: music-library Mar 26 23:13:06 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:13:07 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 23:13:07 volumio volumio[1237]: info: CURURI: music-library/NAS Mar 26 23:13:07 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:13:07 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 23:13:07 volumio volumio[1237]: info: CURURI: music-library/NAS/music Mar 26 23:13:07 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:13:13 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 23:13:13 volumio volumio[1237]: info: CURURI: music-library/NAS/music/台湾 Mar 26 23:13:13 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:13:16 volumio systemd[1]: setdatetime-helper.service: Deactivated successfully. Mar 26 23:13:16 volumio systemd[1]: Finished setdatetime-helper.service - Time Synchronization Helper Service. Mar 26 23:13:16 volumio systemd[1]: setdatetime-helper.service: Consumed 1.278s CPU time. Mar 26 23:13:35 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 23:13:35 volumio volumio[1237]: info: CURURI: music-library/NAS/music/台湾/南方二重唱 Mar 26 23:13:35 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:13:36 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Mar 26 23:13:36 volumio volumio[1237]: info: CURURI: music-library/NAS/music/台湾/南方二重唱/南方二重唱-金选辑 Mar 26 23:13:36 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:13:39 volumio volumio[1237]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::ClearQueue Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::stop Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Mar 26 23:13:39 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:39 volumio volumio[1237]: info: CorePlayQueue::getTrack 8 Mar 26 23:13:39 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:39 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::serviceStop Mar 26 23:13:39 volumio volumio[1237]: info: CorePlayQueue::getTrack 8 Mar 26 23:13:39 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Mar 26 23:13:39 volumio volumio[1237]: info: ControllerMpd::stop Mar 26 23:13:39 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 23:13:39 volumio volumio[1237]: info: CorePlayQueue::clearPlayQueue Mar 26 23:13:39 volumio volumio[1237]: info: CorePlayQueue::saveQueue Mar 26 23:13:39 volumio volumio[1237]: info: CoreCommandRouter::volumioPushQueue Mar 26 23:13:39 volumio volumio[1237]: info: CoreStateMachine::addQueueItems Mar 26 23:13:39 volumio volumio[1237]: info: CorePlayQueue::addQueueItems Mar 26 23:13:39 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:13:39 volumio volumio[1237]: info: Adding Item to queue: music-library/NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue Mar 26 23:13:39 volumio volumio[1237]: info: Exploding uri music-library/NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue in service mpd Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPushQueue Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::saveQueue Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::play index 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::stop Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::play index undefined Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand stop took 699 milliseconds Mar 26 23:13:40 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand stop took 11 milliseconds Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:40 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:40 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:40 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand status took 7 milliseconds Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand clear took 6 milliseconds Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand status took 5 milliseconds Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand status took 4 milliseconds Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand load "NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue" Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:40 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 23:13:40 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:40 volumio volumio[1237]: info: No code Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:40 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Mar 26 23:13:40 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:40 volumio volumio[1237]: info: No code Mar 26 23:13:40 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:40 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:40 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 76ms Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 76ms Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:40 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:40 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:40 volumio volumio[1237]: error: updateQueue error: null Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:40 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 84ms Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 81 milliseconds Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand load "NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue" took 82 milliseconds Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 11ms Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 10ms Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:40 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand play Mar 26 23:13:40 volumio volumio[1237]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 95ms Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:40 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:40 volumio volumio[1237]: info: Mar 26 23:13:40 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:40 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 48ms Mar 26 23:13:40 volumio volumio[1237]: info: sendMpdCommand play took 43 milliseconds Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 42ms Mar 26 23:13:40 volumio volumio[1237]: info: ------------------------------ 41ms Mar 26 23:13:41 volumio volumio[1237]: info: Mar 26 23:13:41 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:41 volumio volumio[1237]: info: Mar 26 23:13:41 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:41 volumio volumio[1237]: info: Mar 26 23:13:41 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:41 volumio volumio[1237]: info: Mar 26 23:13:41 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand status took 5 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:41 volumio volumio[1237]: info: Mar 26 23:13:41 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:41 volumio volumio[1237]: info: Mar 26 23:13:41 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand status took 9 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand status took 8 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand status took 10 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand status took 7 milliseconds Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:41 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Mar 26 23:13:41 volumio volumio[1237]: info: ------------------------------ 23ms Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand status took 13 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:41 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:41 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:41 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:41 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:41 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:41 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:41 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:41 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: ------------------------------ 127ms Mar 26 23:13:41 volumio volumio[1237]: info: ------------------------------ 126ms Mar 26 23:13:41 volumio volumio[1237]: info: ------------------------------ 126ms Mar 26 23:13:41 volumio volumio[1237]: info: ------------------------------ 123ms Mar 26 23:13:41 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 107 milliseconds Mar 26 23:13:41 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:41 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:41 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:41 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:41 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:41 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:41 volumio volumio[1237]: info: ------------------------------ 153ms Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioSeek Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::seek Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: TRACKBLOCK {"uri":"cue://NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue@0","service":"mpd","name":"相知相守","artist":"南方二重唱","album":"金选辑","number":1,"albumart":"/albumart?cacheid=926&web=%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1/%E9%87%91%E9%80%89%E8%BE%91/extralarge&path=%2Fmnt%2F%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91&metadata=false","duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: ControllerMpd::seek Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:48 volumio volumio[1237]: error: null Mar 26 23:13:48 volumio volumio[1237]: info: Mar 26 23:13:48 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:48 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:48 volumio volumio[1237]: info: sendMpdCommand status took 2 milliseconds Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:48 volumio volumio[1237]: info: Mar 26 23:13:48 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:48 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:48 volumio volumio[1237]: info: Mar 26 23:13:48 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:48 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:48 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 7 milliseconds Mar 26 23:13:48 volumio volumio[1237]: info: sendMpdCommand status took 6 milliseconds Mar 26 23:13:48 volumio volumio[1237]: info: sendMpdCommand status took 3 milliseconds Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:48 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":86000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:48 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:48 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:48 volumio volumio[1237]: info: ------------------------------ 56ms Mar 26 23:13:48 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 42 milliseconds Mar 26 23:13:48 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 42 milliseconds Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:48 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:48 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":86000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:48 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:48 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:48 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":86000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:48 volumio volumio[1237]: verbose: CURRENT POSITION 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:48 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:48 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:48 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:48 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:49 volumio volumio[1237]: info: ------------------------------ 122ms Mar 26 23:13:49 volumio volumio[1237]: info: ------------------------------ 121ms Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPlay Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::play index 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::stop Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::serviceStop Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 0 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::stop Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand stop took 11 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::play index undefined Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 6 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand stop took 4 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 4 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 3 milliseconds Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand clear Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:53 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand clear took 6 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 6 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand load "NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue" Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:53 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState stateService stop Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: No code Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 26 23:13:53 volumio volumio[1237]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split') Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 52ms Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 49ms Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 48ms Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:53 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:53 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:53 volumio volumio[1237]: error: updateQueue error: null Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:53 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 46ms Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand load "NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue" took 44 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 8ms Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 7ms Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand play Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:53 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces system playlist update Mar 26 23:13:53 volumio volumio[1237]: info: Ignoring MPD Status Update Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 35ms Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand play took 30 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 30ms Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 29ms Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 8 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 6 milliseconds Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: Mar 26 23:13:53 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 14 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 12 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 10 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 7 milliseconds Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":5,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"有些话不能说","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:53 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus stop Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":5,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"有些话不能说","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:53 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:53 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 49ms Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 64ms Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand status took 50 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 45 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 45 milliseconds Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 44 milliseconds Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":5,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"有些话不能说","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:53 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:53 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":5,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"有些话不能说","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:53 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:53 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":5,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"有些话不能说","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:53 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:53 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 178ms Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 176ms Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 172ms Mar 26 23:13:53 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 161 milliseconds Mar 26 23:13:53 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:53 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":5,"seek":0,"duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"有些话不能说","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:53 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:53 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:53 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:53 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:53 volumio volumio[1237]: info: ------------------------------ 262ms Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioSeek Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::seek Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: TRACKBLOCK {"uri":"cue://NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue@5","service":"mpd","name":"有些话不能说","artist":"南方二重唱","album":"金选辑","number":6,"albumart":"/albumart?cacheid=926&web=%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1/%E9%87%91%E9%80%89%E8%BE%91/extralarge&path=%2Fmnt%2F%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91&metadata=false","duration":294,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: ControllerMpd::seek Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:56 volumio volumio[1237]: error: null Mar 26 23:13:56 volumio volumio[1237]: info: Mar 26 23:13:56 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:56 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:56 volumio volumio[1237]: info: Mar 26 23:13:56 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:56 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:56 volumio volumio[1237]: info: Mar 26 23:13:56 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:13:56 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:13:56 volumio volumio[1237]: info: sendMpdCommand status took 5 milliseconds Mar 26 23:13:56 volumio volumio[1237]: info: sendMpdCommand status took 3 milliseconds Mar 26 23:13:56 volumio volumio[1237]: info: sendMpdCommand status took 2 milliseconds Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:13:56 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 26 23:13:56 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 23:13:56 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:56 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:13:56 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:56 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:56 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:56 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:56 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:56 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:56 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":70000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:13:56 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:13:56 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:56 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:13:56 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:13:56 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:13:56 volumio volumio[1237]: info: ------------------------------ 97ms Mar 26 23:13:56 volumio volumio[1237]: info: ------------------------------ 97ms Mar 26 23:13:56 volumio volumio[1237]: info: ------------------------------ 97ms Mar 26 23:13:57 volumio kernel: hwmon hwmon1: Undervoltage detected! Mar 26 23:14:03 volumio kernel: hwmon hwmon1: Voltage normalised Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioSeek Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::seek Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: TRACKBLOCK {"uri":"cue://NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue@5","service":"mpd","name":"有些话不能说","artist":"南方二重唱","album":"金选辑","number":6,"albumart":"/albumart?cacheid=926&web=%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1/%E9%87%91%E9%80%89%E8%BE%91/extralarge&path=%2Fmnt%2F%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91&metadata=false","duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: ControllerMpd::seek Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:11 volumio volumio[1237]: error: null Mar 26 23:14:11 volumio volumio[1237]: info: Mar 26 23:14:11 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:11 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:11 volumio volumio[1237]: info: Mar 26 23:14:11 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:11 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:11 volumio volumio[1237]: info: Mar 26 23:14:11 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:11 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:11 volumio volumio[1237]: info: sendMpdCommand status took 9 milliseconds Mar 26 23:14:11 volumio volumio[1237]: info: sendMpdCommand status took 7 milliseconds Mar 26 23:14:11 volumio volumio[1237]: info: sendMpdCommand status took 6 milliseconds Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:11 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 26 23:14:11 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 26 23:14:11 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:11 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:11 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":133000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:11 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:11 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:11 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":133000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:11 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:11 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:11 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":133000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:11 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:11 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:11 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:11 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:11 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:11 volumio volumio[1237]: info: ------------------------------ 106ms Mar 26 23:14:11 volumio volumio[1237]: info: ------------------------------ 105ms Mar 26 23:14:11 volumio volumio[1237]: info: ------------------------------ 104ms Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioSeek Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::seek Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: TRACKBLOCK {"uri":"cue://NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue@5","service":"mpd","name":"有些话不能说","artist":"南方二重唱","album":"金选辑","number":6,"albumart":"/albumart?cacheid=926&web=%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1/%E9%87%91%E9%80%89%E8%BE%91/extralarge&path=%2Fmnt%2F%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91&metadata=false","duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: ControllerMpd::seek Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:13 volumio volumio[1237]: error: null Mar 26 23:14:13 volumio volumio[1237]: info: Mar 26 23:14:13 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:13 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:13 volumio volumio[1237]: info: Mar 26 23:14:13 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:13 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:13 volumio volumio[1237]: info: Mar 26 23:14:13 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:13 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:13 volumio volumio[1237]: info: sendMpdCommand status took 13 milliseconds Mar 26 23:14:13 volumio volumio[1237]: info: sendMpdCommand status took 12 milliseconds Mar 26 23:14:13 volumio volumio[1237]: info: sendMpdCommand status took 10 milliseconds Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:13 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 23:14:13 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 26 23:14:13 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 4 milliseconds Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:13 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:13 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":191000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:13 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:13 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:13 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":191000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:13 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:13 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:13 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":191000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:13 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:13 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:13 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:13 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:13 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:13 volumio volumio[1237]: info: ------------------------------ 143ms Mar 26 23:14:13 volumio volumio[1237]: info: ------------------------------ 142ms Mar 26 23:14:13 volumio volumio[1237]: info: ------------------------------ 141ms Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioSeek Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::seek Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: TRACKBLOCK {"uri":"cue://NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue@5","service":"mpd","name":"有些话不能说","artist":"南方二重唱","album":"金选辑","number":6,"albumart":"/albumart?cacheid=926&web=%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1/%E9%87%91%E9%80%89%E8%BE%91/extralarge&path=%2Fmnt%2F%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91&metadata=false","duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2} Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::startPlaybackTimer Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: ControllerMpd::seek Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:15 volumio volumio[1237]: error: null Mar 26 23:14:15 volumio volumio[1237]: info: Mar 26 23:14:15 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:15 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:15 volumio volumio[1237]: info: Mar 26 23:14:15 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:15 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:15 volumio volumio[1237]: info: Mar 26 23:14:15 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:15 volumio volumio[1237]: info: ControllerMpd::getState Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand status Mar 26 23:14:15 volumio volumio[1237]: info: sendMpdCommand status took 5 milliseconds Mar 26 23:14:15 volumio volumio[1237]: info: sendMpdCommand status took 3 milliseconds Mar 26 23:14:15 volumio volumio[1237]: info: sendMpdCommand status took 3 milliseconds Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::parseState Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 26 23:14:15 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 26 23:14:15 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 26 23:14:15 volumio volumio[1237]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:15 volumio volumio[1237]: verbose: ControllerMpd::parseTrackInfo Mar 26 23:14:15 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:15 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:15 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:15 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:15 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:15 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:15 volumio volumio[1237]: info: ControllerMpd::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::servicePushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: verbose: STATE SERVICE {"status":"play","position":0,"seek":29000,"duration":281,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"相知相守","artist":"南方二重唱","album":"金选辑","uri":"NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape","trackType":"ape"} Mar 26 23:14:15 volumio volumio[1237]: verbose: CURRENT POSITION 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::syncState stateService play Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::syncState currentStatus play Mar 26 23:14:15 volumio volumio[1237]: info: Received an update from plugin. extracting info from payload Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:15 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:15 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:15 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:15 volumio volumio[1237]: info: ------------------------------ 83ms Mar 26 23:14:15 volumio volumio[1237]: info: ------------------------------ 83ms Mar 26 23:14:15 volumio volumio[1237]: info: ------------------------------ 83ms Mar 26 23:14:36 volumio volumio[1237]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::ClearQueue Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::stop Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::stPlaybackTimer Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::updateTrackBlock Mar 26 23:14:36 volumio volumio[1237]: info: CorePlayQueue::getTrackBlock Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::pushState Mar 26 23:14:36 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:36 volumio volumio[1237]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 26 23:14:36 volumio volumio[1237]: info: CoreCommandRouter::volumioPushState Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::serviceStop Mar 26 23:14:36 volumio volumio[1237]: info: CorePlayQueue::getTrack 5 Mar 26 23:14:36 volumio volumio[1237]: info: CoreCommandRouter::serviceStop Mar 26 23:14:36 volumio volumio[1237]: info: ControllerMpd::stop Mar 26 23:14:36 volumio volumio[1237]: verbose: ControllerMpd::sendMpdCommand stop Mar 26 23:14:36 volumio volumio[1237]: info: CorePlayQueue::clearPlayQueue Mar 26 23:14:36 volumio volumio[1237]: info: CorePlayQueue::saveQueue Mar 26 23:14:36 volumio volumio[1237]: info: CoreCommandRouter::volumioPushQueue Mar 26 23:14:36 volumio volumio[1237]: info: CoreStateMachine::addQueueItems Mar 26 23:14:36 volumio volumio[1237]: info: CorePlayQueue::addQueueItems Mar 26 23:14:36 volumio volumio[1237]: info: Preload queue cleared Mar 26 23:14:36 volumio volumio[1237]: info: Adding Item to queue: music-library/NAS/music/台湾/南方二重唱/南方二重唱-金选辑 Mar 26 23:14:36 volumio volumio[1237]: info: Exploding uri music-library/NAS/music/台湾/南方二重唱/南方二重唱-金选辑 in service mpd Mar 26 23:14:36 volumio volumio[1237]: info: Mar 26 23:14:36 volumio volumio[1237]: ---------------------------- MPD announces state update: player Mar 26 23:14:36 volumio volumio[1237]: info: ALBUMART /albumart?cacheid=926&web=//extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91%2FCDImage.ape&metadata=false Mar 26 23:14:36 volumio volumio[1237]: info: URI /mnt/NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.ape Mar 26 23:14:36 volumio volumio[1237]: info: ALBUMART /albumart?cacheid=926&web=%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1/%E9%87%91%E9%80%89%E8%BE%91/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91%2FCDImage.cue&metadata=false Mar 26 23:14:36 volumio volumio[1237]: info: URI /mnt/NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue Mar 26 23:14:36 volumio volumio[1237]: info: ALBUMART /albumart?cacheid=926&web=%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1/%E9%87%91%E9%80%89%E8%BE%91/extralarge&path=%2Fmnt%2FNAS%2Fmusic%2F%E5%8F%B0%E6%B9%BE%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1%2F%E5%8D%97%E6%96%B9%E4%BA%8C%E9%87%8D%E5%94%B1-%E9%87%91%E9%80%89%E8%BE%91%2FCDImage.cue&metadata=false Mar 26 23:14:36 volumio volumio[1237]: info: URI /mnt/NAS/music/台湾/南方二重唱/南方二重唱-金选辑/CDImage.cue Mar 26 23:14:36 volumio volumio[1237]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 23:14:36 volumio volumio[1237]: Error: Unable to resolve or reject the same promise twice Mar 26 23:14:36 volumio volumio[1237]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Mar 26 23:14:36 volumio volumio[1237]: at /volumio/app/plugins/music_service/mpd/index.js:2582:21 Mar 26 23:14:36 volumio volumio[1237]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Mar 26 23:14:36 volumio volumio[1237]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Mar 26 23:14:36 volumio volumio[1237]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Mar 26 23:14:36 volumio volumio[1237]: at Socket.emit (node:events:514:28) Mar 26 23:14:36 volumio volumio[1237]: at addChunk (node:internal/streams/readable:343:12) Mar 26 23:14:36 volumio volumio[1237]: at readableAddChunk (node:internal/streams/readable:312:11) Mar 26 23:14:36 volumio volumio[1237]: at Readable.push (node:internal/streams/readable:253:10) Mar 26 23:14:36 volumio volumio[1237]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Mar 26 23:14:36 volumio volumio[1237]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 26 23:14:37 volumio sudo[4407]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-26 23:13' Mar 26 23:14:37 volumio sudo[4407]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="dc61260dec5515dafd2b634881860b4c46c919ff" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Mar 6 16:46:58 UTC 2026" VOLUMIO_VERSION="4.103" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="aa741395b8bfc648ff5d04e312f53d2c"