-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2026-01-11 23:00:53 CST. -- Jan 11 22:59:00 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 5 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 5 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 22:59:00 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-一路向北.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-一路向北.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-发如雪.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-发如雪.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::play index 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 22:59:00 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-枫.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-枫.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-浪漫手机.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-浪漫手机.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-蓝色风暴.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-蓝色风暴.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-逆鳞.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-逆鳞.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-飘移.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-飘移.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-麦芽糖.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-麦芽糖.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-黑色毛衣.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-黑色毛衣.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦&林迈可-四面楚歌.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦&林迈可-四面楚歌.flac Jan 11 22:59:00 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦&梁心颐-珊瑚海.flac Jan 11 22:59:00 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦&梁心颐-珊瑚海.flac Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand stop took 13 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand stop took 2 milliseconds Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:00 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand clear took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac" Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: 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} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: No code Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: 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} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: No code Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 13ms Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 13ms Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:00 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:00 volumio volumio[7148]: error: updateQueue error: null Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:00 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 13ms Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 13 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac" took 13 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 0ms Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 22:59:00 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:00 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:00 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 4ms Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand play took 4 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 3ms Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:00 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 2 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"夜曲","artist":"周杰伦","album":"十一月的萧邦","uri":"NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac","trackType":"flac"} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"夜曲","artist":"周杰伦","album":"十一月的萧邦","uri":"NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac","trackType":"flac"} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:00 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 5ms Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 7ms Jan 11 22:59:00 volumio volumio[7148]: info: Jan 11 22:59:00 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"夜曲","artist":"周杰伦","album":"十一月的萧邦","uri":"NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac","trackType":"flac"} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:00 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"夜曲","artist":"周杰伦","album":"十一月的萧邦","uri":"NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac","trackType":"flac"} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:00 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"夜曲","artist":"周杰伦","album":"十一月的萧邦","uri":"NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac","trackType":"flac"} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:00 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 21ms Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 20ms Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 21ms Jan 11 22:59:00 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 152 milliseconds Jan 11 22:59:00 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:00 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":227,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"524 Kbps","isStreaming":false,"title":"夜曲","artist":"周杰伦","album":"十一月的萧邦","uri":"NAS/NAS/Lossless/周杰伦/12.十一月的萧邦/周杰伦-夜曲.flac","trackType":"flac"} Jan 11 22:59:00 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:00 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:00 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:00 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:00 volumio volumio[7148]: info: ------------------------------ 156ms Jan 11 22:59:06 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 22:59:06 volumio volumio[7148]: info: CURURI: music-library/NAS/NAS/Lossless/梁心颐 Jan 11 22:59:06 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:07 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 22:59:07 volumio volumio[7148]: info: CURURI: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐 Jan 11 22:59:07 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Everything.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-因为你.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-奇妙.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-小树.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-当秋天遇上秋天.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-我不再怕.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-竹篱笆.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-胡椒与盐.flac Jan 11 22:59:07 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-贝壳.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-Crescent%20City.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Everything.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-Everything.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Everything.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-John.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-因为你.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E5%9B%A0%E4%B8%BA%E4%BD%A0.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-因为你.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-奇妙.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E5%A5%87%E5%A6%99.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-奇妙.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-小树.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E5%B0%8F%E6%A0%91.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-小树.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-当秋天遇上秋天.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E5%BD%93%E7%A7%8B%E5%A4%A9%E9%81%87%E4%B8%8A%E7%A7%8B%E5%A4%A9.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-当秋天遇上秋天.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-我不再怕.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E6%88%91%E4%B8%8D%E5%86%8D%E6%80%95.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-我不再怕.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-竹篱笆.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E7%AB%B9%E7%AF%B1%E7%AC%86.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-竹篱笆.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-胡椒与盐.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E8%83%A1%E6%A4%92%E4%B8%8E%E7%9B%90.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-胡椒与盐.flac Jan 11 22:59:08 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-贝壳.flac in service mpd Jan 11 22:59:08 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E6%A2%81%E5%BF%83%E9%A2%90/HELLO%20%E6%A2%81%E5%BF%83%E9%A2%90/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E6%A2%81%E5%BF%83%E9%A2%90%2FHELLO%20%E6%A2%81%E5%BF%83%E9%A2%90%2F%E6%A2%81%E5%BF%83%E9%A2%90-%E8%B4%9D%E5%A3%B3.flac&metadata=false Jan 11 22:59:08 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-贝壳.flac Jan 11 22:59:08 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 22:59:08 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::play index 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 22:59:08 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Everything.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Everything.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-因为你.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-因为你.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-奇妙.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-奇妙.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-小树.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-小树.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-当秋天遇上秋天.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-当秋天遇上秋天.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-我不再怕.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-我不再怕.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-竹篱笆.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-竹篱笆.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-胡椒与盐.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-胡椒与盐.flac Jan 11 22:59:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-贝壳.flac Jan 11 22:59:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-贝壳.flac Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand stop took 9 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand stop took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand clear took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac" Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: 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} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: No code Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: 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} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: No code Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:08 volumio volumio[7148]: error: updateQueue error: null Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 16 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac" took 16 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 22:59:08 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 19ms Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 3ms Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand play took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: Jan 11 22:59:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Crescent City","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac","trackType":"flac"} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Crescent City","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac","trackType":"flac"} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Crescent City","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac","trackType":"flac"} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 10ms Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 14ms Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 11 milliseconds Jan 11 22:59:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 11 milliseconds Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Crescent City","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac","trackType":"flac"} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Crescent City","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac","trackType":"flac"} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":869,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"745 Kbps","isStreaming":false,"title":"Crescent City","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac","trackType":"flac"} Jan 11 22:59:08 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 26ms Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 27ms Jan 11 22:59:08 volumio volumio[7148]: info: ------------------------------ 26ms Jan 11 22:59:10 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 22:59:10 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 22:59:10 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Crescent City.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Everything.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-Everything.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::play index 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 22:59:10 volumio volumio[7148]: info: Preload queue cleared Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-因为你.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-因为你.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-奇妙.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-奇妙.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-小树.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-小树.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-当秋天遇上秋天.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-当秋天遇上秋天.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-我不再怕.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-我不再怕.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-竹篱笆.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-竹篱笆.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-胡椒与盐.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-胡椒与盐.flac Jan 11 22:59:10 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-贝壳.flac Jan 11 22:59:10 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-贝壳.flac Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand stop took 10 milliseconds Jan 11 22:59:10 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand stop took 1 milliseconds Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:10 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:10 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:10 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand clear took 1 milliseconds Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac" Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:10 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: 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} Jan 11 22:59:10 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:10 volumio volumio[7148]: info: No code Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:10 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: 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} Jan 11 22:59:10 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:10 volumio volumio[7148]: info: No code Jan 11 22:59:10 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:10 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:10 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:10 volumio volumio[7148]: info: ------------------------------ 14ms Jan 11 22:59:10 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:10 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:10 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:10 volumio volumio[7148]: error: updateQueue error: null Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:10 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:10 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 15 milliseconds Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac" took 16 milliseconds Jan 11 22:59:10 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:10 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 22:59:10 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 22:59:10 volumio volumio[7148]: info: ------------------------------ 17ms Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:10 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:10 volumio volumio[7148]: info: Jan 11 22:59:10 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 22:59:10 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 22:59:10 volumio volumio[7148]: info: ------------------------------ 3ms Jan 11 22:59:10 volumio volumio[7148]: info: sendMpdCommand play took 2 milliseconds Jan 11 22:59:10 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 22:59:11 volumio volumio[7148]: info: Jan 11 22:59:11 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:11 volumio volumio[7148]: info: Jan 11 22:59:11 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:11 volumio volumio[7148]: info: Jan 11 22:59:11 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:11 volumio volumio[7148]: info: Jan 11 22:59:11 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"John","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac","trackType":"flac"} Jan 11 22:59:11 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 22:59:11 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 22:59:11 volumio volumio[7148]: info: Jan 11 22:59:11 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:11 volumio volumio[7148]: info: Jan 11 22:59:11 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"John","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac","trackType":"flac"} Jan 11 22:59:11 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:11 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"John","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac","trackType":"flac"} Jan 11 22:59:11 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:11 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: ------------------------------ 11ms Jan 11 22:59:11 volumio volumio[7148]: info: ------------------------------ 11ms Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 11 22:59:11 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:11 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"John","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac","trackType":"flac"} Jan 11 22:59:11 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:11 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"John","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac","trackType":"flac"} Jan 11 22:59:11 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:11 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":183,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"John","artist":"梁心颐","album":"HELLO 梁心颐","uri":"NAS/NAS/Lossless/梁心颐/HELLO 梁心颐/梁心颐-John.flac","trackType":"flac"} Jan 11 22:59:11 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 22:59:11 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 22:59:11 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:11 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 22:59:11 volumio volumio[7148]: info: ------------------------------ 24ms Jan 11 22:59:11 volumio volumio[7148]: info: ------------------------------ 23ms Jan 11 22:59:11 volumio volumio[7148]: info: ------------------------------ 23ms Jan 11 22:59:57 volumio volumio[7148]: verbose: New Socket.io Connection to 172.18.9.119 from 172.18.9.117 UA: Mozilla/5.0 (Linux; Android 16; V2507A Build/BP2A.250605.031.A3_V000L1) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/138.0.7204.179 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jan 11 22:59:57 volumio volumio[7148]: info: Received Get System Info Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 22:59:57 volumio volumio[7148]: info: Discovery: Getting this device information Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::volumioGetState Jan 11 22:59:57 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::volumioGetState Jan 11 22:59:57 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::volumioGetVisibleSources Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::volumioGetState Jan 11 22:59:57 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 11 22:59:57 volumio volumio[7148]: info: Received Get System Info Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 11 22:59:57 volumio volumio[7148]: info: Discovery: Getting this device information Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::volumioGetState Jan 11 22:59:57 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::volumioGetState Jan 11 22:59:57 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 22:59:57 volumio volumio[7148]: info: Listing playlists Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::volumioGetQueue Jan 11 22:59:57 volumio volumio[7148]: info: CoreStateMachine::getQueue Jan 11 22:59:57 volumio volumio[7148]: info: CorePlayQueue::getQueue Jan 11 22:59:57 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jan 11 23:00:01 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 23:00:01 volumio volumio[7148]: info: CURURI: music-library/NAS/NAS/Lossless/宇多田光 Jan 11 23:00:01 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:02 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 11 23:00:02 volumio volumio[7148]: info: CURURI: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光 Jan 11 23:00:02 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:02 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:02 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:02 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:02 volumio volumio[7148]: info: Preloading song: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:02 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac in service mpd Jan 11 23:00:02 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E5%AE%87%E5%A4%9A%E7%94%B0%E3%83%92%E3%82%AB%E3%83%AB%20%26%20Skrillex/Face%20My%20Fears/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F%5BSony%5D%20-%20%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F0013210141.flac&metadata=false Jan 11 23:00:02 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:02 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac in service mpd Jan 11 23:00:02 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E5%AE%87%E5%A4%9A%E7%94%B0%E3%83%92%E3%82%AB%E3%83%AB/Face%20My%20Fears/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F%5BSony%5D%20-%20%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F0013210142.flac&metadata=false Jan 11 23:00:02 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:02 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac in service mpd Jan 11 23:00:02 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E5%AE%87%E5%A4%9A%E7%94%B0%E3%83%92%E3%82%AB%E3%83%AB%20%26%20Skrillex/Face%20My%20Fears/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F%5BSony%5D%20-%20%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F0013210143.flac&metadata=false Jan 11 23:00:02 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:02 volumio volumio[7148]: info: Exploding uri music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac in service mpd Jan 11 23:00:02 volumio volumio[7148]: info: ALBUMART /albumart?cacheid=456&web=%E5%AE%87%E5%A4%9A%E7%94%B0%E3%83%92%E3%82%AB%E3%83%AB/Face%20My%20Fears/extralarge&path=%2Fmnt%2FNAS%2FNAS%2FLossless%2F%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F%5BSony%5D%20-%20%E5%AE%87%E5%A4%9A%E7%94%B0%E5%85%89%2F0013210144.flac&metadata=false Jan 11 23:00:02 volumio volumio[7148]: info: URI /mnt/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:03 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 23:00:03 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:03 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:03 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:03 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::play index 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:03 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:03 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:03 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:03 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:03 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:03 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:03 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand stop took 8 milliseconds Jan 11 23:00:03 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand stop took 2 milliseconds Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:03 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:03 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:03 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand clear took 1 milliseconds Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac" Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:03 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:03 volumio volumio[7148]: error: updateQueue error: null Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:03 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand status took 2 milliseconds Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac" took 1 milliseconds Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:03 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 23:00:03 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: 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} Jan 11 23:00:03 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:03 volumio volumio[7148]: info: No code Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:03 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: 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} Jan 11 23:00:03 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:03 volumio volumio[7148]: info: No code Jan 11 23:00:03 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:03 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:03 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:03 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 18ms Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:03 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 23:00:03 volumio volumio[7148]: info: sendMpdCommand play took 16 milliseconds Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:03 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:03 volumio volumio[7148]: info: Jan 11 23:00:03 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:03 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:03 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:04 volumio volumio[7148]: info: Jan 11 23:00:04 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:04 volumio volumio[7148]: info: Jan 11 23:00:04 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:04 volumio volumio[7148]: info: Jan 11 23:00:04 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:04 volumio volumio[7148]: info: Jan 11 23:00:04 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:04 volumio volumio[7148]: info: Jan 11 23:00:04 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:04 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:04 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:04 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: ------------------------------ 3ms Jan 11 23:00:04 volumio volumio[7148]: info: ------------------------------ 5ms Jan 11 23:00:04 volumio volumio[7148]: info: Jan 11 23:00:04 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:04 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:04 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:04 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:04 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:04 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:04 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: ------------------------------ 14ms Jan 11 23:00:04 volumio volumio[7148]: info: ------------------------------ 14ms Jan 11 23:00:04 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 23:00:04 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 12 milliseconds Jan 11 23:00:04 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:04 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:04 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:04 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:04 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:04 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:04 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 23:00:05 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:05 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:05 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:05 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:05 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:05 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::play index 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:05 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:05 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:05 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:05 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:05 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand stop took 9 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand stop took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:05 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand clear took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac" Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: 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} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: No code Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 8ms Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:05 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:05 volumio volumio[7148]: error: updateQueue error: null Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:05 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 9 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 8ms Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac" took 8 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: 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} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: No code Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:05 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:05 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 8ms Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand play took 8 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:05 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:05 volumio volumio[7148]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E5%AE%87%E5%A4%9A%E7%94%B0%E3%83%92%E3%82%AB%E3%83%AB/Face%20My%20Fears/0bac261e-a495-413e-b9f7-dd0aebcfee52.jpg' Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 2 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 2 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: Jan 11 23:00:05 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":278,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"誓い","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac","trackType":"flac"} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":278,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"誓い","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac","trackType":"flac"} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:05 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":278,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"誓い","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac","trackType":"flac"} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:05 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 7ms Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 11ms Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 11ms Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 11 23:00:05 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 9 milliseconds Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:05 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":278,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"誓い","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac","trackType":"flac"} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:05 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":278,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"誓い","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac","trackType":"flac"} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:05 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1244,"duration":278,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"4615 Kbps","isStreaming":false,"title":"誓い","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac","trackType":"flac"} Jan 11 23:00:05 volumio volumio[7148]: verbose: CURRENT POSITION 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:05 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:05 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:05 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 20ms Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 19ms Jan 11 23:00:05 volumio volumio[7148]: info: ------------------------------ 19ms Jan 11 23:00:08 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 1 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:08 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:08 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:08 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::play index 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand stop took 6 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand stop took 2 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand clear took 0 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac" Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 23:00:08 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:08 volumio volumio[7148]: error: updateQueue error: null Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac" took 1 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 23:00:08 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 3ms Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 3ms Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand play took 2 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:08 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 3 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 4 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 4 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 0 milliseconds Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Think Twice","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac","trackType":"flac"} Jan 11 23:00:08 volumio volumio[7148]: verbose: CURRENT POSITION 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 5ms Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: Jan 11 23:00:08 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 2 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Think Twice","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac","trackType":"flac"} Jan 11 23:00:08 volumio volumio[7148]: verbose: CURRENT POSITION 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Think Twice","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac","trackType":"flac"} Jan 11 23:00:08 volumio volumio[7148]: verbose: CURRENT POSITION 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Think Twice","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac","trackType":"flac"} Jan 11 23:00:08 volumio volumio[7148]: verbose: CURRENT POSITION 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 21ms Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 22ms Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 19ms Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand status took 17 milliseconds Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 17 milliseconds Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Think Twice","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac","trackType":"flac"} Jan 11 23:00:08 volumio volumio[7148]: verbose: CURRENT POSITION 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 24ms Jan 11 23:00:08 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 10 milliseconds Jan 11 23:00:08 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:08 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":274,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Don't Think Twice","artist":"宇多田ヒカル","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac","trackType":"flac"} Jan 11 23:00:08 volumio volumio[7148]: verbose: CURRENT POSITION 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:08 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:08 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:08 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:08 volumio volumio[7148]: info: ------------------------------ 34ms Jan 11 23:00:17 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 3 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:17 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:17 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:17 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:17 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:17 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:17 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:17 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::play index 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:17 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:17 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:17 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand stop took 7 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand stop took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:17 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand clear took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac" Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: 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} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: No code Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: 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} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: No code Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 13ms Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 13ms Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:17 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:17 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:17 volumio volumio[7148]: error: updateQueue error: null Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:17 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 14ms Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac" took 14 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 23:00:17 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:17 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:17 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 3ms Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand play took 2 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (English Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac","trackType":"flac"} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (English Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac","trackType":"flac"} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:17 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 5ms Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 7ms Jan 11 23:00:17 volumio volumio[7148]: info: Jan 11 23:00:17 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (English Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac","trackType":"flac"} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:17 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (English Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac","trackType":"flac"} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:17 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (English Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac","trackType":"flac"} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:17 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 48ms Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 49ms Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 50ms Jan 11 23:00:17 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 53 milliseconds Jan 11 23:00:17 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:17 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (English Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac","trackType":"flac"} Jan 11 23:00:17 volumio volumio[7148]: verbose: CURRENT POSITION 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:17 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:17 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:17 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:17 volumio volumio[7148]: info: ------------------------------ 76ms Jan 11 23:00:34 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::ClearQueue Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::stPlaybackTimer Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::serviceStop Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 2 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::serviceStop Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::stop Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::clearPlayQueue Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:34 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:34 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:34 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPlay Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::play index 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::addQueueItems Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::addQueueItems Jan 11 23:00:34 volumio volumio[7148]: info: Preload queue cleared Jan 11 23:00:34 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:34 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210142.flac Jan 11 23:00:34 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:34 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210143.flac Jan 11 23:00:34 volumio volumio[7148]: info: Adding Item to queue: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:34 volumio volumio[7148]: info: Using cached record of: music-library/NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210144.flac Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::stop Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushQueue Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::saveQueue Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::play index undefined Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::updateTrackBlock Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrackBlock Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::startPlaybackTimer Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::clearAddPlayTracks NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand stop Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand stop took 7 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand stop took 2 milliseconds Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand clear Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:34 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 0 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand clear took 1 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 1 milliseconds Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac" Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: 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} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: No code Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: 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} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService stop Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: No code Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 13ms Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 14ms Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:34 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:34 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:34 volumio volumio[7148]: error: updateQueue error: null Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:34 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 15ms Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 14 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand add "NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac" took 14 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand play Jan 11 23:00:34 volumio volumio[7148]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 16ms Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:34 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces system playlist update Jan 11 23:00:34 volumio volumio[7148]: info: Ignoring MPD Status Update Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand play took 2 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 2ms Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 1ms Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 3 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 3 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 2 milliseconds Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: Jan 11 23:00:34 volumio volumio[7148]: ---------------------------- MPD announces state update: player Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::getState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand status Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 6 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 3 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand status took 3 milliseconds Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseState Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus stop Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:34 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:34 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 31ms Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 48ms Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 49ms Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 42 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 41 milliseconds Jan 11 23:00:34 volumio volumio[7148]: info: sendMpdCommand playlistinfo took 40 milliseconds Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:34 volumio volumio[7148]: verbose: ControllerMpd::parseTrackInfo Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:34 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:34 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: ControllerMpd::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::servicePushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":222,"samplerate":"96 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Face My Fears (Japanese Version)","artist":"宇多田ヒカル & Skrillex","album":"Face My Fears","uri":"NAS/NAS/Lossless/宇多田光/[Sony] - 宇多田光/0013210141.flac","trackType":"flac"} Jan 11 23:00:34 volumio volumio[7148]: verbose: CURRENT POSITION 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState stateService play Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::syncState currentStatus play Jan 11 23:00:34 volumio volumio[7148]: info: Received an update from plugin. extracting info from payload Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: CoreStateMachine::pushState Jan 11 23:00:34 volumio volumio[7148]: info: CorePlayQueue::getTrack 0 Jan 11 23:00:34 volumio volumio[7148]: info: CoreCommandRouter::volumioPushState Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 79ms Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 76ms Jan 11 23:00:34 volumio volumio[7148]: info: ------------------------------ 75ms Jan 11 23:00:53 volumio volumio[7148]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 23:00:53 volumio volumio[7148]: Error: connect ETIMEDOUT 108.160.170.52:443 Jan 11 23:00:53 volumio volumio[7148]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 11 23:00:53 volumio volumio[7148]: errno: -110, Jan 11 23:00:53 volumio volumio[7148]: code: 'ETIMEDOUT', Jan 11 23:00:53 volumio volumio[7148]: syscall: 'connect', Jan 11 23:00:53 volumio volumio[7148]: address: '108.160.170.52', Jan 11 23:00:53 volumio volumio[7148]: port: 443 Jan 11 23:00:53 volumio volumio[7148]: } Jan 11 23:00:53 volumio volumio[7148]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 11 23:00:53 volumio sudo[8244]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-11 22:59 Jan 11 23:00:53 volumio sudo[8244]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b43c85cc0006d3f1efecba101311ec96e334d1fd" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 11 Dec 2025 05:43:24 PM CET" VOLUMIO_VERSION="3.886" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="15d0241b0cd805792809f3ddf4a0fc4e"