-- Logs begin at Thu 2025-12-25 05:00:25 GMT, end at Thu 2025-12-25 05:28:49 GMT. -- Dec 25 05:27:00 volumio volumio[833]: info: Preload queue cleared Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::ClearQueue Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::stop Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::stPlaybackTimer Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrackBlock Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::serviceStop Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::serviceStop Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::stop Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::saveQueue Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::addQueueItems Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::addQueueItems Dec 25 05:27:00 volumio volumio[833]: info: Preload queue cleared Dec 25 05:27:00 volumio volumio[833]: info: Adding Item to queue: albums://%E4%B9%85%E7%9F%B3%E8%AE%A9/%E9%93%B6%E6%B2%B3%E9%89%84%E9%81%93%E3%81%AE%E5%A4%9C Dec 25 05:27:00 volumio volumio[833]: info: Exploding uri albums://%E4%B9%85%E7%9F%B3%E8%AE%A9/%E9%93%B6%E6%B2%B3%E9%89%84%E9%81%93%E3%81%AE%E5%A4%9C in service mpd Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::saveQueue Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrackBlock Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPlay Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::play index 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::stop Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::play index undefined Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand stop took 38 milliseconds Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand stop took 15 milliseconds Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:27:00 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand status took 4 milliseconds Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand clear took 3 milliseconds Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand status took 3 milliseconds Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand status took 2 milliseconds Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape" Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 25 05:27:00 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:00 volumio volumio[833]: info: No code Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 25 05:27:00 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:00 volumio volumio[833]: info: No code Dec 25 05:27:00 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:00 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:00 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 41ms Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 40ms Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:27:00 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:27:00 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:27:00 volumio volumio[833]: error: updateQueue error: null Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:27:00 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 44ms Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand add "NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape" took 42 milliseconds Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 5ms Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 4ms Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand play Dec 25 05:27:00 volumio volumio[833]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 52ms Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:27:00 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:27:00 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 10ms Dec 25 05:27:00 volumio volumio[833]: info: sendMpdCommand play took 8 milliseconds Dec 25 05:27:00 volumio volumio[833]: info: ------------------------------ 7ms Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:00 volumio volumio[833]: info: Dec 25 05:27:00 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:00 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:00 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand status took 150 milliseconds Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand status took 149 milliseconds Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:27:01 volumio volumio[833]: info: Dec 25 05:27:01 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand playlistinfo took 5 milliseconds Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand playlistinfo took 6 milliseconds Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"久石让","album":"银河鉄道の夜","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape","trackType":"ape"} Dec 25 05:27:01 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"久石让","album":"银河鉄道の夜","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape","trackType":"ape"} Dec 25 05:27:01 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:27:01 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: ------------------------------ 178ms Dec 25 05:27:01 volumio volumio[833]: info: ------------------------------ 181ms Dec 25 05:27:01 volumio volumio[833]: info: Dec 25 05:27:01 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:01 volumio volumio[833]: info: Dec 25 05:27:01 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand playlistinfo took 32 milliseconds Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand status took 27 milliseconds Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"久石让","album":"银河鉄道の夜","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape","trackType":"ape"} Dec 25 05:27:01 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:27:01 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: ------------------------------ 198ms Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand status took 32 milliseconds Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand playlistinfo took 30 milliseconds Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"久石让","album":"银河鉄道の夜","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape","trackType":"ape"} Dec 25 05:27:01 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:27:01 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: ------------------------------ 82ms Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 25 05:27:01 volumio volumio[833]: info: sendMpdCommand playlistinfo took 26 milliseconds Dec 25 05:27:01 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"久石让","album":"银河鉄道の夜","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape","trackType":"ape"} Dec 25 05:27:01 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:27:01 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":243,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"久石让","album":"银河鉄道の夜","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/久石让3/2007-银河铁道之夜 Nokto De La Galaksia Fervojo/CDImage.ape","trackType":"ape"} Dec 25 05:27:01 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:27:01 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:27:01 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:27:01 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:27:01 volumio volumio[833]: info: ------------------------------ 96ms Dec 25 05:27:01 volumio volumio[833]: info: ------------------------------ 96ms Dec 25 05:28:22 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Dec 25 05:28:22 volumio volumio[833]: info: CURURI: albums://%E4%BB%93%E6%9C%A8%E9%BA%BB%E8%A1%A3/%E9%A3%8E%E3%81%AE%E3%82%89%E3%82%89%E3%82%89 Dec 25 05:28:22 volumio volumio[833]: info: Preload queue cleared Dec 25 05:28:22 volumio volumio[833]: info: Preloading song: music-library/NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape Dec 25 05:28:22 volumio volumio[833]: info: Exploding uri music-library/NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape in service mpd Dec 25 05:28:22 volumio volumio[833]: info: ALBUMART /albumart?cacheid=482&web=%E4%BB%93%E6%9C%A8%E9%BA%BB%E8%A1%A3/%E9%A3%8E%E3%81%AE%E3%82%89%E3%82%89%E3%82%89/extralarge&path=%2Fmnt%2FNAS%2F%E9%9F%B3%E4%B9%90%2F%24RECYCLE.BIN%2FS-1-5-21-3950662165-3691418517-2208978556-500%2F%24RIYF7WN%2F%E6%97%A5%E8%AF%AD%2F%E6%97%A5%E9%9F%A9%E9%9F%B3%E4%B9%90%E5%90%88%E8%BE%91-92G%2F%E4%BB%93%E6%9C%A8%E9%BA%BB%E8%A1%A32%2F2003-%E9%A3%8E%E3%81%AE%E3%82%89%E3%82%89%E3%82%89%2FCDImage.ape&metadata=false Dec 25 05:28:22 volumio volumio[833]: info: URI /mnt/NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape Dec 25 05:28:22 volumio volumio[833]: info: No valid Plugin REST Endpoint Dec 25 05:28:22 volumio volumio[833]: info: No valid Plugin REST Endpoint Dec 25 05:28:22 volumio volumio[833]: info: No valid Plugin REST Endpoint Dec 25 05:28:22 volumio volumio[833]: info: No valid Plugin REST Endpoint Dec 25 05:28:22 volumio volumio[833]: info: No valid Plugin REST Endpoint Dec 25 05:28:24 volumio volumio[833]: info: Preload queue cleared Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioReplaceandPlayItems Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::ClearQueue Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::stop Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::stPlaybackTimer Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrackBlock Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::serviceStop Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::serviceStop Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::stop Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::clearPlayQueue Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::saveQueue Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::addQueueItems Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::addQueueItems Dec 25 05:28:24 volumio volumio[833]: info: Preload queue cleared Dec 25 05:28:24 volumio volumio[833]: info: Adding Item to queue: albums://%E4%BB%93%E6%9C%A8%E9%BA%BB%E8%A1%A3/%E9%A3%8E%E3%81%AE%E3%82%89%E3%82%89%E3%82%89 Dec 25 05:28:24 volumio volumio[833]: info: Exploding uri albums://%E4%BB%93%E6%9C%A8%E9%BA%BB%E8%A1%A3/%E9%A3%8E%E3%81%AE%E3%82%89%E3%82%89%E3%82%89 in service mpd Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushQueue Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::saveQueue Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::updateTrackBlock Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrackBlock Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPlay Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::play index 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::stop Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::play index undefined Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::setConsumeUpdateService undefined Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::startPlaybackTimer Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::clearAddPlayTracks NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand stop Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand stop took 30 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand stop took 7 milliseconds Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand clear Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:28:24 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 8 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand clear took 7 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 3 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 2 milliseconds Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand add "NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape" Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 25 05:28:24 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: No code Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 25 05:28:24 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState stateService stop Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: No code Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 42ms Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 40ms Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:28:24 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:28:24 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:28:24 volumio volumio[833]: error: updateQueue error: null Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:28:24 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 44ms Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand playlistinfo took 42 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand add "NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape" took 42 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 4ms Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand play Dec 25 05:28:24 volumio volumio[833]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 54ms Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:28:24 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces system playlist update Dec 25 05:28:24 volumio volumio[833]: info: Ignoring MPD Status Update Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 12ms Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand play took 14 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 13ms Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 12ms Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 133 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 131 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 138 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 7 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand playlistinfo took 7 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand playlistinfo took 8 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 4 milliseconds Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"仓木麻衣","album":"风のららら","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape","trackType":"ape"} Dec 25 05:28:24 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus stop Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"仓木麻衣","album":"风のららら","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape","trackType":"ape"} Dec 25 05:28:24 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:28:24 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 162ms Dec 25 05:28:24 volumio volumio[833]: info: ------------------------------ 177ms Dec 25 05:28:24 volumio volumio[833]: info: Dec 25 05:28:24 volumio volumio[833]: ---------------------------- MPD announces state update: player Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::getState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand status Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand playlistinfo took 37 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand playlistinfo took 36 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand playlistinfo took 35 milliseconds Dec 25 05:28:24 volumio volumio[833]: info: sendMpdCommand status took 1 milliseconds Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::parseState Dec 25 05:28:24 volumio volumio[833]: verbose: ControllerMpd::sendMpdCommand playlistinfo Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":1279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"仓木麻衣","album":"风のららら","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape","trackType":"ape"} Dec 25 05:28:24 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:28:24 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:24 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":1279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"仓木麻衣","album":"风のららら","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape","trackType":"ape"} Dec 25 05:28:24 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:28:24 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:28:24 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:24 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 05:28:24 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:25 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":1279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"仓木麻衣","album":"风のららら","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape","trackType":"ape"} Dec 25 05:28:25 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:28:25 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:25 volumio volumio[833]: info: ------------------------------ 218ms Dec 25 05:28:25 volumio volumio[833]: info: ------------------------------ 88ms Dec 25 05:28:25 volumio volumio[833]: info: ------------------------------ 84ms Dec 25 05:28:25 volumio volumio[833]: info: sendMpdCommand playlistinfo took 48 milliseconds Dec 25 05:28:25 volumio volumio[833]: verbose: ControllerMpd::parseTrackInfo Dec 25 05:28:25 volumio volumio[833]: info: ControllerMpd::pushState Dec 25 05:28:25 volumio volumio[833]: info: CoreCommandRouter::servicePushState Dec 25 05:28:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:25 volumio volumio[833]: verbose: STATE SERVICE {"status":"play","position":0,"seek":842,"duration":1279,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"CDImage.ape","artist":"仓木麻衣","album":"风のららら","uri":"NAS/音乐/$RECYCLE.BIN/S-1-5-21-3950662165-3691418517-2208978556-500/$RIYF7WN/日语/日韩音乐合辑-92G/仓木麻衣2/2003-风のららら/CDImage.ape","trackType":"ape"} Dec 25 05:28:25 volumio volumio[833]: verbose: CURRENT POSITION 0 Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::syncState stateService play Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::syncState currentStatus play Dec 25 05:28:25 volumio volumio[833]: info: Received an update from plugin. extracting info from payload Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:25 volumio volumio[833]: info: CoreStateMachine::pushState Dec 25 05:28:25 volumio volumio[833]: info: CorePlayQueue::getTrack 0 Dec 25 05:28:25 volumio volumio[833]: info: CoreCommandRouter::volumioPushState Dec 25 05:28:25 volumio volumio[833]: info: ------------------------------ 65ms Dec 25 05:28:49 volumio volumio[833]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 05:28:49 volumio volumio[833]: Error: connect ETIMEDOUT 103.226.246.99:443 Dec 25 05:28:49 volumio volumio[833]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Dec 25 05:28:49 volumio volumio[833]: errno: -110, Dec 25 05:28:49 volumio volumio[833]: code: 'ETIMEDOUT', Dec 25 05:28:49 volumio volumio[833]: syscall: 'connect', Dec 25 05:28:49 volumio volumio[833]: address: '103.226.246.99', Dec 25 05:28:49 volumio volumio[833]: port: 443 Dec 25 05:28:49 volumio volumio[833]: } Dec 25 05:28:49 volumio volumio[833]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 05:28:49 volumio sudo[8591]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-25 05:27 Dec 25 05:28:49 volumio sudo[8591]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 07:31:13 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="674d725e3f749f2a23785c9f94a28aa3"