-- Logs begin at Wed 2024-05-01 12:44:56 CST, end at Wed 2024-05-01 12:54:34 CST. -- May 01 12:53:39 volumio volumio[981]: info: VolumeController::SetAlsaVolume53 May 01 12:53:39 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:39 volumio volumio[981]: info: CorePlayQueue::getTrack 22 May 01 12:53:39 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:39 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:41 volumio volumio[981]: info: VolumeController::SetAlsaVolume37 May 01 12:53:41 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:41 volumio volumio[981]: info: CorePlayQueue::getTrack 22 May 01 12:53:41 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:41 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioNext May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::next May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::stPlaybackTimer May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::updateTrackBlock May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrackBlock May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 22 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::serviceStop May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 22 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::serviceStop May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::stop May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand stop took 7 milliseconds May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::play index undefined May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::startPlaybackTimer May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::clearAddPlayTracks USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::updateTrackBlock May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrackBlock May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand stop took 1 milliseconds May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand clear May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:43 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand playlistinfo took 3 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand clear took 4 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 2 milliseconds May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand add "USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape" May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"马斯卡尼：独幕剧《乡村骑士》 - 间奏曲","artist":"群星","album":"极致：古典名曲选集 (Disc2)","uri":"USB/9C33-6BBD/Music/Classics/Cavalleria rusticana - Intermezzo (乡村骑士 - 间奏曲)-National Philharmonic Orchestra.ape","trackType":"ape"} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: No code May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: 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} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: No code May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: 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} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: No code May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 68ms May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 62ms May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 62ms May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:43 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:43 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:43 volumio volumio[981]: error: updateQueue error: null May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:43 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 67ms May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand add "USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape" took 65 milliseconds May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 5ms May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 4ms May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand play May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:43 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:43 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 29ms May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand play took 27 milliseconds May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 26ms May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 26ms May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 7 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 6 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: May 01 12:53:43 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand playlistinfo took 13 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand playlistinfo took 14 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand playlistinfo took 13 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand playlistinfo took 13 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 8 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梁祝_古筝","artist":"纯音乐","album":"民韵合集","uri":"USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape","trackType":"ape"} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梁祝_古筝","artist":"纯音乐","album":"民韵合集","uri":"USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape","trackType":"ape"} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:43 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梁祝_古筝","artist":"纯音乐","album":"民韵合集","uri":"USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape","trackType":"ape"} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:43 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梁祝_古筝","artist":"纯音乐","album":"民韵合集","uri":"USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape","trackType":"ape"} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:43 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 58ms May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 88ms May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 85ms May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 84ms May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand playlistinfo took 65 milliseconds May 01 12:53:43 volumio volumio[981]: info: sendMpdCommand playlistinfo took 65 milliseconds May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:43 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梁祝_古筝","artist":"纯音乐","album":"民韵合集","uri":"USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape","trackType":"ape"} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:43 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":206,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梁祝_古筝","artist":"纯音乐","album":"民韵合集","uri":"USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape","trackType":"ape"} May 01 12:53:43 volumio volumio[981]: verbose: CURRENT POSITION 23 May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:43 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:43 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:43 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 104ms May 01 12:53:43 volumio volumio[981]: info: ------------------------------ 103ms May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioNext May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::next May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::stPlaybackTimer May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::updateTrackBlock May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrackBlock May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::serviceStop May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 23 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::serviceStop May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::stop May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand stop took 6 milliseconds May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::play index undefined May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::setConsumeUpdateService undefined May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::startPlaybackTimer May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::clearAddPlayTracks USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::updateTrackBlock May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrackBlock May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 2 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand stop took 1 milliseconds May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand clear May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:45 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand playlistinfo took 4 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand clear took 4 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 1 milliseconds May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand add "USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape" May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"梁祝_古筝","artist":"纯音乐","album":"民韵合集","uri":"USB/9C33-6BBD/Music/Classics/梁祝-纯音乐.ape","trackType":"ape"} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: No code May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: 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} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: No code May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: 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} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: No code May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 55ms May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 51ms May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 50ms May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:45 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:45 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:45 volumio volumio[981]: error: updateQueue error: null May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:45 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 53ms May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand add "USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape" took 52 milliseconds May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 4ms May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 3ms May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand play May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:45 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces system playlist update May 01 12:53:45 volumio volumio[981]: info: Ignoring MPD Status Update May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 22ms May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand play took 21 milliseconds May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 20ms May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 19ms May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 5 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 4 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 2 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 2 milliseconds May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: May 01 12:53:45 volumio volumio[981]: ---------------------------- MPD announces state update: player May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::getState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand status May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand playlistinfo took 7 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand playlistinfo took 6 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 3 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand status took 2 milliseconds May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseState May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::sendMpdCommand playlistinfo May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":335,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Andante cantabile 如歌的行板","artist":"群星","album":"浪漫小提琴名曲集","uri":"USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape","trackType":"ape"} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus stop May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":335,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Andante cantabile 如歌的行板","artist":"群星","album":"浪漫小提琴名曲集","uri":"USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape","trackType":"ape"} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:45 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":335,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Andante cantabile 如歌的行板","artist":"群星","album":"浪漫小提琴名曲集","uri":"USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape","trackType":"ape"} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:45 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":335,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Andante cantabile 如歌的行板","artist":"群星","album":"浪漫小提琴名曲集","uri":"USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape","trackType":"ape"} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:45 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 29ms May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 48ms May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 47ms May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 46ms May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand playlistinfo took 35 milliseconds May 01 12:53:45 volumio volumio[981]: info: sendMpdCommand playlistinfo took 35 milliseconds May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:45 volumio volumio[981]: verbose: ControllerMpd::parseTrackInfo May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":335,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Andante cantabile 如歌的行板","artist":"群星","album":"浪漫小提琴名曲集","uri":"USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape","trackType":"ape"} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:45 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ControllerMpd::pushState May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::servicePushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: verbose: STATE SERVICE {"status":"play","position":0,"seek":960,"duration":335,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Andante cantabile 如歌的行板","artist":"群星","album":"浪漫小提琴名曲集","uri":"USB/9C33-6BBD/Music/Classics/Andante cantabile (如歌的行板)-Classical Artists.ape","trackType":"ape"} May 01 12:53:45 volumio volumio[981]: verbose: CURRENT POSITION 24 May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState stateService play May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::syncState currentStatus play May 01 12:53:45 volumio volumio[981]: info: Received an update from plugin. extracting info from payload May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: CoreStateMachine::pushState May 01 12:53:45 volumio volumio[981]: info: CorePlayQueue::getTrack 24 May 01 12:53:45 volumio volumio[981]: info: CoreCommandRouter::volumioPushState May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 64ms May 01 12:53:45 volumio volumio[981]: info: ------------------------------ 63ms May 01 12:53:55 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:53:55 volumio volumio[981]: info: CURURI: music-library/NAS May 01 12:53:55 volumio volumio[981]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory May 01 12:53:55 volumio volumio[981]: info: Preload queue cleared May 01 12:54:00 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:54:00 volumio volumio[981]: info: CURURI: music-library May 01 12:54:00 volumio volumio[981]: info: Preload queue cleared May 01 12:54:01 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:54:01 volumio volumio[981]: info: CURURI: music-library/USB May 01 12:54:01 volumio volumio[981]: info: Preload queue cleared May 01 12:54:02 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:54:02 volumio volumio[981]: info: CURURI: music-library/USB/9C33-6BBD May 01 12:54:02 volumio volumio[981]: info: Preload queue cleared May 01 12:54:12 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri May 01 12:54:12 volumio volumio[981]: info: CURURI: music-library/USB/9C33-6BBD/Download May 01 12:54:12 volumio volumio[981]: info: Preload queue cleared May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/11983.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/1439213372142.mp4 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/1749.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/3369003147.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/乐秀视频第4部_20150725023532.mp4 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/心爱的再会啦 - 伍佰.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/10961.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/11089.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/2492.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/6888.mp3 May 01 12:54:12 volumio volumio[981]: info: Preloading song: music-library/USB/9C33-6BBD/Download/7949.mp3 May 01 12:54:12 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/11983.mp3 in service mpd May 01 12:54:12 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=//extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F11983.mp3&metadata=false May 01 12:54:12 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/11983.mp3 May 01 12:54:12 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/1439213372142.mp4 in service mpd May 01 12:54:12 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=//extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F1439213372142.mp4&metadata=false May 01 12:54:12 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/1439213372142.mp4 May 01 12:54:12 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/1749.mp3 in service mpd May 01 12:54:12 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=//extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F1749.mp3&metadata=false May 01 12:54:12 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/1749.mp3 May 01 12:54:12 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/3369003147.mp3 in service mpd May 01 12:54:12 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=//extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F3369003147.mp3&metadata=false May 01 12:54:12 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/3369003147.mp3 May 01 12:54:13 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/乐秀视频第4部_20150725023532.mp4 in service mpd May 01 12:54:13 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=//extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F%E4%B9%90%E7%A7%80%E8%A7%86%E9%A2%91%E7%AC%AC4%E9%83%A8_20150725023532.mp4&metadata=false May 01 12:54:13 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/乐秀视频第4部_20150725023532.mp4 May 01 12:54:13 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/心爱的再会啦 - 伍佰.mp3 in service mpd May 01 12:54:13 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=//extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F%E5%BF%83%E7%88%B1%E7%9A%84%E5%86%8D%E4%BC%9A%E5%95%A6%20-%20%E4%BC%8D%E4%BD%B0.mp3&metadata=false May 01 12:54:13 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/心爱的再会啦 - 伍佰.mp3 May 01 12:54:13 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/10961.mp3 in service mpd May 01 12:54:13 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F10961.mp3&metadata=false May 01 12:54:13 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/10961.mp3 May 01 12:54:13 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/11089.mp3 in service mpd May 01 12:54:13 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F11089.mp3&metadata=false May 01 12:54:13 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/11089.mp3 May 01 12:54:13 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/2492.mp3 in service mpd May 01 12:54:13 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F2492.mp3&metadata=false May 01 12:54:13 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/2492.mp3 May 01 12:54:13 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/6888.mp3 in service mpd May 01 12:54:13 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F6888.mp3&metadata=false May 01 12:54:13 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/6888.mp3 May 01 12:54:13 volumio volumio[981]: info: Exploding uri music-library/USB/9C33-6BBD/Download/7949.mp3 in service mpd May 01 12:54:13 volumio volumio[981]: info: ALBUMART /albumart?cacheid=218&web=%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/%C3%95%C2%BE%C2%B3%C2%A4%C3%8B%C3%98%C2%B2%C3%84(sc.chinaz.com)/extralarge&path=%2Fmnt%2FUSB%2F9C33-6BBD%2FDownload%2F7949.mp3&metadata=false May 01 12:54:13 volumio volumio[981]: info: URI /mnt/USB/9C33-6BBD/Download/7949.mp3 May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:54:26 volumio volumio[981]: info: Retrieving Cloud Streaming UI May 01 12:54:26 volumio volumio[981]: info: Getting Tidal Cloud Configuration May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:54:26 volumio volumio[981]: info: Getting Qobuz Cloud Configuration May 01 12:54:26 volumio volumio[981]: info: Asking plugin for UI Config May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:54:26 volumio volumio[981]: info: Getting Spotify Cloud Configuration May 01 12:54:26 volumio volumio[981]: info: Asking plugin for UI Config May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:54:26 volumio volumio[981]: info: Saving Spotify Acccount May 01 12:54:26 volumio volumio[981]: info: Got Tidal Cloud Configuration May 01 12:54:26 volumio volumio[981]: info: Got it May 01 12:54:26 volumio volumio[981]: info: Got it May 01 12:54:26 volumio volumio[981]: error: Could not retrieve Spotify Config from plugin Spotify: no section found May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::getUIConfigOnPlugin May 01 12:54:26 volumio volumio[981]: error: Error retrieving Highresaudio conf: TypeError: Cannot read property 'onSave' of undefined May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::volumioGetBrowseSources May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:54:26 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares May 01 12:54:30 volumio volumio[981]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats May 01 12:54:34 volumio volumio[981]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:54:34 volumio volumio[981]: Error: connect ETIMEDOUT 75.126.124.162:443 May 01 12:54:34 volumio volumio[981]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { May 01 12:54:34 volumio volumio[981]: errno: -110, May 01 12:54:34 volumio volumio[981]: code: 'ETIMEDOUT', May 01 12:54:34 volumio volumio[981]: syscall: 'connect', May 01 12:54:34 volumio volumio[981]: address: '75.126.124.162', May 01 12:54:34 volumio volumio[981]: port: 443 May 01 12:54:34 volumio volumio[981]: } May 01 12:54:34 volumio volumio[981]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 01 12:54:34 volumio sudo[2061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-05-01 12:53 May 01 12:54:34 volumio sudo[2061]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET" VOLUMIO_VERSION="3.631" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"