-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Wed 2024-11-27 11:13:47 CST. -- Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::volumioNext Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::next Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::stPlaybackTimer Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::serviceStop Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::serviceStop Nov 27 11:12:04 volumio volumio[1130]: info: ControllerMpd::stop Nov 27 11:12:04 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:04 volumio volumio[1130]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 27 11:12:04 volumio volumio[1130]: info: Nov 27 11:12:04 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:04 volumio volumio[1130]: info: sendMpdCommand stop took 33 milliseconds Nov 27 11:12:04 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:04 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrack 2 Nov 27 11:12:04 volumio volumio[1130]: info: sendMpdCommand status took 1 milliseconds Nov 27 11:12:04 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:04 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:04 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:12:04 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:04 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:04 volumio volumio[1130]: 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":"Fear Of Falling","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Fear Of Falling.wav","trackType":"wav"} Nov 27 11:12:04 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::syncState stateService stop Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:04 volumio volumio[1130]: info: No code Nov 27 11:12:04 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:04 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:04 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:04 volumio volumio[1130]: info: ------------------------------ 12ms Nov 27 11:12:07 volumio volumio[1130]: info: CoreCommandRouter::volumioPlay Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:07 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:07 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand stop took 0 milliseconds Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 11:12:07 volumio volumio[1130]: info: Nov 27 11:12:07 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:07 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand clear took 0 milliseconds Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav" Nov 27 11:12:07 volumio volumio[1130]: error: updateQueue error: null Nov 27 11:12:07 volumio volumio[1130]: info: Nov 27 11:12:07 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:07 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:07 volumio volumio[1130]: info: ------------------------------ 0ms Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand add "USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav" took 0 milliseconds Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Nov 27 11:12:07 volumio volumio[1130]: info: ------------------------------ 1ms Nov 27 11:12:07 volumio volumio[1130]: info: Nov 27 11:12:07 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand play took 0 milliseconds Nov 27 11:12:07 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand status took 46 milliseconds Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:07 volumio volumio[1130]: info: Nov 27 11:12:07 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:07 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand status took 1 milliseconds Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:07 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:07 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:07 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:07 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Angel","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav","trackType":"wav"} Nov 27 11:12:07 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:07 volumio volumio[1130]: info: ------------------------------ 50ms Nov 27 11:12:07 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 27 11:12:07 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:07 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:07 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:07 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:07 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Angel","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav","trackType":"wav"} Nov 27 11:12:07 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:07 volumio volumio[1130]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:07 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:07 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:07 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:07 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:07 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:07 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:07 volumio volumio[1130]: info: ------------------------------ 11ms Nov 27 11:12:09 volumio volumio[1130]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Nov 27 11:12:09 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Nov 27 11:12:09 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:09 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Katherine%20Jenkins/Believe/9f48ccd7-7a90-4160-b4fe-e953bd19efba.png' Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::volumioNext Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::next Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::stPlaybackTimer Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::serviceStop Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::serviceStop Nov 27 11:12:17 volumio volumio[1130]: info: ControllerMpd::stop Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:17 volumio volumio[1130]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 27 11:12:17 volumio volumio[1130]: info: Nov 27 11:12:17 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand stop took 38 milliseconds Nov 27 11:12:17 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks USB/9AED-B3E1/JAZZ/Katherine Jenkins - Fear Of Falling.wav Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand status took 1 milliseconds Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand stop took 1 milliseconds Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 11:12:17 volumio volumio[1130]: info: Nov 27 11:12:17 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:17 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand clear took 0 milliseconds Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "USB/9AED-B3E1/JAZZ/Katherine Jenkins - Fear Of Falling.wav" Nov 27 11:12:17 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: 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":"Angel","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav","trackType":"wav"} Nov 27 11:12:17 volumio volumio[1130]: verbose: CURRENT POSITION 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::syncState stateService stop Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:17 volumio volumio[1130]: info: No code Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:17 volumio volumio[1130]: info: ------------------------------ 12ms Nov 27 11:12:17 volumio volumio[1130]: error: updateQueue error: null Nov 27 11:12:17 volumio volumio[1130]: info: Nov 27 11:12:17 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:17 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:17 volumio volumio[1130]: info: ------------------------------ 11ms Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand add "USB/9AED-B3E1/JAZZ/Katherine Jenkins - Fear Of Falling.wav" took 10 milliseconds Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Nov 27 11:12:17 volumio volumio[1130]: info: Nov 27 11:12:17 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:17 volumio volumio[1130]: info: ------------------------------ 6ms Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand play took 6 milliseconds Nov 27 11:12:17 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:17 volumio volumio[1130]: info: Nov 27 11:12:17 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand status took 21 milliseconds Nov 27 11:12:17 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand status took 4 milliseconds Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 3 milliseconds Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:17 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fear Of Falling","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Fear Of Falling.wav","trackType":"wav"} Nov 27 11:12:17 volumio volumio[1130]: verbose: CURRENT POSITION 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:17 volumio volumio[1130]: info: ------------------------------ 27ms Nov 27 11:12:17 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:12:17 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:17 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":434,"duration":239,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fear Of Falling","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Fear Of Falling.wav","trackType":"wav"} Nov 27 11:12:17 volumio volumio[1130]: verbose: CURRENT POSITION 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:17 volumio volumio[1130]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:17 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:17 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:17 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:17 volumio volumio[1130]: info: ------------------------------ 10ms Nov 27 11:12:19 volumio volumio[1130]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:19 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Katherine%20Jenkins/Believe/9f48ccd7-7a90-4160-b4fe-e953bd19efba.png' Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::volumioNext Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::next Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::stPlaybackTimer Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::serviceStop Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::serviceStop Nov 27 11:12:19 volumio volumio[1130]: info: ControllerMpd::stop Nov 27 11:12:19 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:19 volumio volumio[1130]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 27 11:12:19 volumio volumio[1130]: info: Nov 27 11:12:19 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:19 volumio volumio[1130]: info: sendMpdCommand stop took 37 milliseconds Nov 27 11:12:19 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:19 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 2 Nov 27 11:12:19 volumio volumio[1130]: info: sendMpdCommand status took 0 milliseconds Nov 27 11:12:19 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:19 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:19 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:12:19 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:19 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:19 volumio volumio[1130]: 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":"Fear Of Falling","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Fear Of Falling.wav","trackType":"wav"} Nov 27 11:12:19 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::syncState stateService stop Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:19 volumio volumio[1130]: info: No code Nov 27 11:12:19 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:19 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:19 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:19 volumio volumio[1130]: info: ------------------------------ 5ms Nov 27 11:12:22 volumio volumio[1130]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 27 11:12:22 volumio volumio[1130]: info: Retrying Login Due to Network Error Nov 27 11:12:25 volumio volumio[1130]: info: CoreCommandRouter::volumioplayNextItems Nov 27 11:12:25 volumio volumio[1130]: info: CoreStateMachine::playNextItems Nov 27 11:12:25 volumio volumio[1130]: info: CorePlayQueue::addPlayNextItems Nov 27 11:12:25 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:12:25 volumio volumio[1130]: info: Adding Item to play next: albums://Katherine%20Jenkins/Believe Nov 27 11:12:25 volumio volumio[1130]: info: Using cached record of: albums://Katherine%20Jenkins/Believe Nov 27 11:12:25 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:25 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:12:25 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:25 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 27 11:12:28 volumio volumio[1130]: info: Discovery: Getting this device information Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 27 11:12:28 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::ClearQueue Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::clearPlayQueue Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::addQueueItems Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::addQueueItems Nov 27 11:12:28 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:12:28 volumio volumio[1130]: info: Adding Item to queue: albums://Katherine%20Jenkins/Believe Nov 27 11:12:28 volumio volumio[1130]: info: Using cached record of: albums://Katherine%20Jenkins/Believe Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::volumioPlay Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::play index 0 Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand stop took 3 milliseconds Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 11:12:28 volumio volumio[1130]: info: Nov 27 11:12:28 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:28 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand clear took 1 milliseconds Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav" Nov 27 11:12:28 volumio volumio[1130]: error: updateQueue error: null Nov 27 11:12:28 volumio volumio[1130]: info: Nov 27 11:12:28 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:28 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:28 volumio volumio[1130]: info: ------------------------------ 1ms Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand add "USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav" took 1 milliseconds Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Nov 27 11:12:28 volumio volumio[1130]: info: ------------------------------ 0ms Nov 27 11:12:28 volumio volumio[1130]: info: Nov 27 11:12:28 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand play took 4 milliseconds Nov 27 11:12:28 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:28 volumio volumio[1130]: info: Nov 27 11:12:28 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand status took 14 milliseconds Nov 27 11:12:28 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand status took 2 milliseconds Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 2 milliseconds Nov 27 11:12:28 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:12:28 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:28 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:28 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Angel","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav","trackType":"wav"} Nov 27 11:12:28 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:28 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:28 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":434,"duration":354,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Angel","artist":"Katherine Jenkins","album":"Believe","uri":"USB/9AED-B3E1/JAZZ/Katherine Jenkins - Angel.wav","trackType":"wav"} Nov 27 11:12:28 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:28 volumio volumio[1130]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:28 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:28 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:28 volumio volumio[1130]: info: ------------------------------ 21ms Nov 27 11:12:28 volumio volumio[1130]: info: ------------------------------ 10ms Nov 27 11:12:30 volumio volumio[1130]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: python-requests/2.21.0 Engine version: 3 Transport: polling Total Clients: 11 Nov 27 11:12:30 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Nov 27 11:12:30 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:30 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Katherine%20Jenkins/Believe/9f48ccd7-7a90-4160-b4fe-e953bd19efba.png' Nov 27 11:12:32 volumio volumio[1130]: info: MyVolumio login type: Token Nov 27 11:12:35 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Katherine%20Jenkins/Believe/9f48ccd7-7a90-4160-b4fe-e953bd19efba.png' Nov 27 11:12:35 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Crystal%20Gayle/Best%20Always/842cc5d3-bf04-409a-99f9-68b8e3d67be2.jpg' Nov 27 11:12:42 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 27 11:12:42 volumio volumio[1130]: info: CURURI: albums://Emi%20Fujita/Best%20Audiophile%20Vioces%20V3 Nov 27 11:12:42 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:12:42 volumio volumio[1130]: info: Preloading song: music-library/USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav Nov 27 11:12:42 volumio volumio[1130]: info: Exploding uri music-library/USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav in service mpd Nov 27 11:12:42 volumio volumio[1130]: info: ALBUMART /albumart?cacheid=569&web=Emi%20Fujita/Best%20Audiophile%20Vioces%20V3/extralarge&path=%2Fmnt%2FUSB%2F9AED-B3E1%2FJAZZ%2FEmi%20Fujita%20-%20Fields%20Of%20Gold.wav&metadata=false Nov 27 11:12:42 volumio volumio[1130]: info: URI /mnt/USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav Nov 27 11:12:42 volumio volumio[1130]: info: No valid Plugin REST Endpoint Nov 27 11:12:42 volumio volumio[1130]: info: No valid Plugin REST Endpoint Nov 27 11:12:42 volumio volumio[1130]: info: No valid Plugin REST Endpoint Nov 27 11:12:46 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::ClearQueue Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::stPlaybackTimer Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::serviceStop Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::serviceStop Nov 27 11:12:46 volumio volumio[1130]: info: ControllerMpd::stop Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::clearPlayQueue Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::addQueueItems Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::addQueueItems Nov 27 11:12:46 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:12:46 volumio volumio[1130]: info: Adding Item to queue: albums://Emi%20Fujita/Best%20Audiophile%20Vioces%20V3 Nov 27 11:12:46 volumio volumio[1130]: info: Exploding uri albums://Emi%20Fujita/Best%20Audiophile%20Vioces%20V3 in service mpd Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::volumioPlay Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::play index 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:12:46 volumio volumio[1130]: info: Nov 27 11:12:46 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand stop took 26 milliseconds Nov 27 11:12:46 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand stop took 18 milliseconds Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 11:12:46 volumio volumio[1130]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 27 11:12:46 volumio volumio[1130]: info: Nov 27 11:12:46 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:46 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand status took 2 milliseconds Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand clear took 2 milliseconds Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav" Nov 27 11:12:46 volumio volumio[1130]: error: updateQueue error: null Nov 27 11:12:46 volumio volumio[1130]: info: Nov 27 11:12:46 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:12:46 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:12:46 volumio volumio[1130]: info: ------------------------------ 0ms Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand add "USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav" took 1 milliseconds Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Nov 27 11:12:46 volumio volumio[1130]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Nov 27 11:12:46 volumio volumio[1130]: info: ------------------------------ 3ms Nov 27 11:12:46 volumio volumio[1130]: info: ------------------------------ 2ms Nov 27 11:12:46 volumio volumio[1130]: info: Nov 27 11:12:46 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand play took 1 milliseconds Nov 27 11:12:46 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand status took 35 milliseconds Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:46 volumio volumio[1130]: info: Nov 27 11:12:46 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:12:46 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:46 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fields Of Gold","artist":"Emi Fujita","album":"Best Audiophile Vioces V3","uri":"USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav","trackType":"wav"} Nov 27 11:12:46 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:12:46 volumio volumio[1130]: info: ------------------------------ 37ms Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand status took 1 milliseconds Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:12:46 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 27 11:12:46 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:12:46 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":617,"duration":302,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Fields Of Gold","artist":"Emi Fujita","album":"Best Audiophile Vioces V3","uri":"USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav","trackType":"wav"} Nov 27 11:12:46 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:12:46 volumio volumio[1130]: info: Received an update from plugin. extracting info from payload Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:46 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:12:46 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:46 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:12:46 volumio volumio[1130]: info: ------------------------------ 6ms Nov 27 11:12:54 volumio volumio[1130]: info: Listing playlists Nov 27 11:12:58 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 27 11:12:58 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 27 11:12:58 volumio volumio[1130]: info: Discovery: Getting this device information Nov 27 11:12:58 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Nov 27 11:12:58 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:12:58 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 27 11:13:02 volumio volumio[1130]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 27 11:13:02 volumio volumio[1130]: info: Retrying Login Due to Network Error Nov 27 11:13:04 volumio volumio[1130]: info: CoreCommandRouter::volumioAddQueueItems Nov 27 11:13:04 volumio volumio[1130]: info: CoreStateMachine::addQueueItems Nov 27 11:13:04 volumio volumio[1130]: info: CorePlayQueue::addQueueItems Nov 27 11:13:04 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:13:04 volumio volumio[1130]: info: Adding Item to queue: albums://Emi%20Fujita/Best%20Audiophile%20Vioces%20V3 Nov 27 11:13:04 volumio volumio[1130]: info: Using cached record of: albums://Emi%20Fujita/Best%20Audiophile%20Vioces%20V3 Nov 27 11:13:04 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:13:04 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:13:04 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:13:04 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::volumioNext Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::next Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::stPlaybackTimer Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::serviceStop Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::serviceStop Nov 27 11:13:11 volumio volumio[1130]: info: ControllerMpd::stop Nov 27 11:13:11 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:13:11 volumio volumio[1130]: info: touch_display: Setting screensaver timeout to 120 seconds. Nov 27 11:13:11 volumio volumio[1130]: info: Nov 27 11:13:11 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:13:11 volumio volumio[1130]: info: sendMpdCommand stop took 20 milliseconds Nov 27 11:13:11 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:13:11 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrack 1 Nov 27 11:13:11 volumio volumio[1130]: info: sendMpdCommand status took 0 milliseconds Nov 27 11:13:11 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:13:11 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:13:11 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:13:11 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:13:11 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:11 volumio volumio[1130]: 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":"Fields Of Gold","artist":"Emi Fujita","album":"Best Audiophile Vioces V3","uri":"USB/9AED-B3E1/JAZZ/Emi Fujita - Fields Of Gold.wav","trackType":"wav"} Nov 27 11:13:11 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::syncState stateService stop Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:13:11 volumio volumio[1130]: info: No code Nov 27 11:13:11 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:13:11 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:11 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:13:11 volumio volumio[1130]: info: ------------------------------ 8ms Nov 27 11:13:12 volumio volumio[1130]: info: MyVolumio login type: Token Nov 27 11:13:19 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Nov 27 11:13:19 volumio volumio[1130]: info: CURURI: albums://Andrea%20Zonn/Best%20Audiophile%20Voices%20II Nov 27 11:13:19 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:13:19 volumio volumio[1130]: info: Preloading song: music-library/USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav Nov 27 11:13:19 volumio volumio[1130]: info: Exploding uri music-library/USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav in service mpd Nov 27 11:13:19 volumio volumio[1130]: info: ALBUMART /albumart?cacheid=569&web=Andrea%20Zonn/Best%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2F9AED-B3E1%2FJAZZ%2FAndrea%20Zonn%20-%20Better%20be%20Home%20Soon.wav&metadata=false Nov 27 11:13:19 volumio volumio[1130]: info: URI /mnt/USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav Nov 27 11:13:21 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::ClearQueue Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::clearPlayQueue Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::addQueueItems Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::addQueueItems Nov 27 11:13:21 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:13:21 volumio volumio[1130]: info: Adding Item to queue: albums://Andrea%20Zonn/Best%20Audiophile%20Voices%20II Nov 27 11:13:21 volumio volumio[1130]: info: Exploding uri albums://Andrea%20Zonn/Best%20Audiophile%20Voices%20II in service mpd Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::volumioPlay Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::play index 0 Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::stop Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::play index undefined Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::startPlaybackTimer Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::clearAddPlayTracks USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand stop Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand stop took 1 milliseconds Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand clear Nov 27 11:13:21 volumio volumio[1130]: info: Nov 27 11:13:21 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:13:21 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand clear took 0 milliseconds Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand add "USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav" Nov 27 11:13:21 volumio volumio[1130]: error: updateQueue error: null Nov 27 11:13:21 volumio volumio[1130]: info: Nov 27 11:13:21 volumio volumio[1130]: ---------------------------- MPD announces system playlist update Nov 27 11:13:21 volumio volumio[1130]: info: Ignoring MPD Status Update Nov 27 11:13:21 volumio volumio[1130]: info: ------------------------------ 1ms Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand add "USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav" took 1 milliseconds Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand play Nov 27 11:13:21 volumio volumio[1130]: info: ------------------------------ 0ms Nov 27 11:13:21 volumio volumio[1130]: info: Nov 27 11:13:21 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand play took 1 milliseconds Nov 27 11:13:21 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:13:21 volumio volumio[1130]: info: Nov 27 11:13:21 volumio volumio[1130]: ---------------------------- MPD announces state update: player Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand status took 18 milliseconds Nov 27 11:13:21 volumio volumio[1130]: info: ControllerMpd::getState Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand status Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand status took 1 milliseconds Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::parseState Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 1 milliseconds Nov 27 11:13:21 volumio volumio[1130]: info: sendMpdCommand playlistinfo took 0 milliseconds Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:13:21 volumio volumio[1130]: verbose: ControllerMpd::parseTrackInfo Nov 27 11:13:21 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:21 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better be Home Soon","artist":"Andrea Zonn","album":"Best Audiophile Voices II","uri":"USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav","trackType":"wav"} Nov 27 11:13:21 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus stop Nov 27 11:13:21 volumio volumio[1130]: info: ControllerMpd::pushState Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::servicePushState Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:21 volumio volumio[1130]: verbose: STATE SERVICE {"status":"play","position":0,"seek":526,"duration":267,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Better be Home Soon","artist":"Andrea Zonn","album":"Best Audiophile Voices II","uri":"USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav","trackType":"wav"} Nov 27 11:13:21 volumio volumio[1130]: verbose: CURRENT POSITION 0 Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::syncState stateService play Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::syncState currentStatus play Nov 27 11:13:21 volumio volumio[1130]: info: Received an update from plugin. extracting info from payload Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:13:21 volumio volumio[1130]: info: CoreStateMachine::pushState Nov 27 11:13:21 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:21 volumio volumio[1130]: info: CoreCommandRouter::volumioPushState Nov 27 11:13:21 volumio volumio[1130]: info: ------------------------------ 22ms Nov 27 11:13:21 volumio volumio[1130]: info: ------------------------------ 9ms Nov 27 11:13:21 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Andrea%20Zonn/Best%20Audiophile%20Voices%20II/1bea5239-7906-4d84-bb0d-80baccab64e4.jpg' Nov 27 11:13:21 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Andrea%20Zonn/Best%20Audiophile%20Voices%20II/1bea5239-7906-4d84-bb0d-80baccab64e4.jpg' Nov 27 11:13:21 volumio volumio[1130]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Andrea%20Zonn/Best%20Audiophile%20Voices%20II/1bea5239-7906-4d84-bb0d-80baccab64e4.jpg' Nov 27 11:13:28 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 27 11:13:28 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 27 11:13:28 volumio volumio[1130]: info: Discovery: Getting this device information Nov 27 11:13:28 volumio volumio[1130]: info: CoreCommandRouter::volumioGetState Nov 27 11:13:28 volumio volumio[1130]: info: CorePlayQueue::getTrack 0 Nov 27 11:13:28 volumio volumio[1130]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 27 11:13:29 volumio volumio[1130]: info: CoreCommandRouter::volumioplayNextItems Nov 27 11:13:29 volumio volumio[1130]: info: CoreStateMachine::playNextItems Nov 27 11:13:29 volumio volumio[1130]: info: CorePlayQueue::addPlayNextItems Nov 27 11:13:29 volumio volumio[1130]: info: Preload queue cleared Nov 27 11:13:29 volumio volumio[1130]: info: Adding Item to play next: music-library/USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav Nov 27 11:13:29 volumio volumio[1130]: info: Using cached record of: music-library/USB/9AED-B3E1/JAZZ/Andrea Zonn - Better be Home Soon.wav Nov 27 11:13:29 volumio volumio[1130]: info: CoreCommandRouter::volumioPushQueue Nov 27 11:13:29 volumio volumio[1130]: info: CorePlayQueue::saveQueue Nov 27 11:13:29 volumio volumio[1130]: info: CoreStateMachine::updateTrackBlock Nov 27 11:13:29 volumio volumio[1130]: info: CorePlayQueue::getTrackBlock Nov 27 11:13:37 volumio volumio[1130]: info: Listing playlists Nov 27 11:13:42 volumio volumio[1130]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Nov 27 11:13:42 volumio volumio[1130]: info: Retrying Login Due to Network Error Nov 27 11:13:47 volumio volumio[1130]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 11:13:47 volumio volumio[1130]: Error: connect ETIMEDOUT 31.13.95.169:443 Nov 27 11:13:47 volumio volumio[1130]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Nov 27 11:13:47 volumio volumio[1130]: errno: -110, Nov 27 11:13:47 volumio volumio[1130]: code: 'ETIMEDOUT', Nov 27 11:13:47 volumio volumio[1130]: syscall: 'connect', Nov 27 11:13:47 volumio volumio[1130]: address: '31.13.95.169', Nov 27 11:13:47 volumio volumio[1130]: port: 443 Nov 27 11:13:47 volumio volumio[1130]: } Nov 27 11:13:47 volumio volumio[1130]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 27 11:13:47 volumio sudo[17935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-11-27 11:12 Nov 27 11:13:47 volumio sudo[17935]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 06:51:56 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="b9009e0280f50389e80a537357ff3961"