-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Mon 2024-08-26 14:41:24 BST. -- Aug 26 14:40:12 volumio-1 volumio[748]: info: Preload queue cleared Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::ClearQueue Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::stop Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::clearPlayQueue Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::saveQueue Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushQueue Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::addQueueItems Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::addQueueItems Aug 26 14:40:12 volumio-1 volumio[748]: info: Preload queue cleared Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/02 - When You Really Loved Someone.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/02 - When You Really Loved Someone.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/03 - Perfume In The Breeze.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/03 - Perfume In The Breeze.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/04 - I Was A Flower.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/04 - I Was A Flower.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/05 - I Should've Followed You Home (ft. Gary Barlow).flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/05 - I Should've Followed You Home (ft. Gary Barlow).flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/06 - Past Forever.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/06 - Past Forever.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/07 - Dance Your Pain Away.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/07 - Dance Your Pain Away.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/08 - Bubble.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/08 - Bubble.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/09 - Back On Your Radio.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/09 - Back On Your Radio.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/10 - I Keep Them On The Floor Beside My Bed.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: Exploding uri music-library/INTERNAL/music/Agnetha Faltskog/A/10 - I Keep Them On The Floor Beside My Bed.flac in service mpd Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F01%20-%20The%20One%20Who%20Loves%20You%20Now.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F02%20-%20When%20You%20Really%20Loved%20Someone.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/02 - When You Really Loved Someone.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F03%20-%20Perfume%20In%20The%20Breeze.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/03 - Perfume In The Breeze.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F04%20-%20I%20Was%20A%20Flower.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/04 - I Was A Flower.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F05%20-%20I%20Should've%20Followed%20You%20Home%20(ft.%20Gary%20Barlow).flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/05 - I Should've Followed You Home (ft. Gary Barlow).flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F06%20-%20Past%20Forever.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/06 - Past Forever.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F07%20-%20Dance%20Your%20Pain%20Away.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/07 - Dance Your Pain Away.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F08%20-%20Bubble.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/08 - Bubble.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F09%20-%20Back%20On%20Your%20Radio.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/09 - Back On Your Radio.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: ALBUMART /albumart?cacheid=921&web=Agnetha%20Faltskog/A/extralarge&path=%2Fmnt%2FINTERNAL%2Fmusic%2FAgnetha%20Faltskog%2FA%2F10%20-%20I%20Keep%20Them%20On%20The%20Floor%20Beside%20My%20Bed.flac&metadata=false Aug 26 14:40:12 volumio-1 volumio[748]: info: URI /mnt/INTERNAL/music/Agnetha Faltskog/A/10 - I Keep Them On The Floor Beside My Bed.flac Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushQueue Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::saveQueue Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::updateTrackBlock Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrackBlock Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPlay Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::play index 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::stop Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::play index undefined Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::startPlaybackTimer Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand stop took 1 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:12 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand clear took 2 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac" Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:12 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:12 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:12 volumio-1 volumio[748]: error: updateQueue error: null Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:12 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 13ms Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand add "INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac" took 11 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 10ms Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 9ms Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand play Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:12 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:12 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:12 volumio-1 volumio[748]: error: Upnp client error: Error: This socket has been ended by the other party Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 17ms Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand play took 10 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 11ms Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 10ms Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:12 volumio-1 volumio[748]: info: An error occurred saving queue to disk: Error: EACCES: permission denied, open '/data/queue' Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand status took 8 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand status took 7 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand status took 6 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand status took 3 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:12 volumio-1 volumio[748]: info: Aug 26 14:40:12 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 6 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand status took 3 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:12 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus stop Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:12 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:12 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:12 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:12 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:12 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:12 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 47ms Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 62ms Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 59ms Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 58ms Aug 26 14:40:12 volumio-1 volumio[748]: info: An error occurred saving queue to disk: Error: EACCES: permission denied, open '/data/queue' Aug 26 14:40:12 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 42 milliseconds Aug 26 14:40:12 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:12 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:12 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:12 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:12 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:12 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:12 volumio-1 volumio[748]: info: ------------------------------ 66ms Aug 26 14:40:12 volumio-1 volumio[748]: Error saving last played file: Error: EACCES: permission denied, open '/data/laststates.json' Aug 26 14:40:12 volumio-1 volumio[748]: An internal error occurred while serving an albumart. Details: Error: EACCES: permission denied, mkdir '/data/albumart' Aug 26 14:40:12 volumio-1 volumio[748]: at Object.mkdirSync (fs.js:987:3) Aug 26 14:40:12 volumio-1 volumio[748]: at mkdirsSync (/volumio/node_modules/fs-extra/lib/mkdirs/mkdirs-sync.js:31:9) Aug 26 14:40:12 volumio-1 volumio[748]: at mkdirsSync (/volumio/node_modules/fs-extra/lib/mkdirs/mkdirs-sync.js:37:16) Aug 26 14:40:12 volumio-1 volumio[748]: at Object.mkdirsSync (/volumio/node_modules/fs-extra/lib/mkdirs/mkdirs-sync.js:37:16) Aug 26 14:40:12 volumio-1 volumio[748]: at Object.createFileSync (/volumio/node_modules/fs-extra/lib/ensure/file.js:37:11) Aug 26 14:40:12 volumio-1 volumio[748]: at searchInFolder (/volumio/app/plugins/miscellanea/albumart/albumart.js:238:16) Aug 26 14:40:12 volumio-1 volumio[748]: at processRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:385:11) Aug 26 14:40:12 volumio-1 volumio[748]: at processExpressRequest (/volumio/app/plugins/miscellanea/albumart/albumart.js:433:17) Aug 26 14:40:12 volumio-1 volumio[748]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Aug 26 14:40:12 volumio-1 volumio[748]: at next (/volumio/node_modules/express/lib/router/route.js:137:13) Aug 26 14:40:12 volumio-1 volumio[748]: at Route.dispatch (/volumio/node_modules/express/lib/router/route.js:112:3) Aug 26 14:40:12 volumio-1 volumio[748]: at Layer.handle [as handle_request] (/volumio/node_modules/express/lib/router/layer.js:95:5) Aug 26 14:40:20 volumio-1 volumio[748]: info: Preload queue cleared Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::ClearQueue Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::stop Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::updateTrackBlock Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrackBlock Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::serviceStop Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::serviceStop Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::stop Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::clearPlayQueue Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::saveQueue Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushQueue Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::addQueueItems Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::addQueueItems Aug 26 14:40:20 volumio-1 volumio[748]: info: Preload queue cleared Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/02 - When You Really Loved Someone.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/02 - When You Really Loved Someone.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/03 - Perfume In The Breeze.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/03 - Perfume In The Breeze.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/04 - I Was A Flower.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/04 - I Was A Flower.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/05 - I Should've Followed You Home (ft. Gary Barlow).flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/05 - I Should've Followed You Home (ft. Gary Barlow).flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/06 - Past Forever.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/06 - Past Forever.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/07 - Dance Your Pain Away.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/07 - Dance Your Pain Away.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/08 - Bubble.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/08 - Bubble.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/09 - Back On Your Radio.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/09 - Back On Your Radio.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/10 - I Keep Them On The Floor Beside My Bed.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/10 - I Keep Them On The Floor Beside My Bed.flac Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushQueue Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::saveQueue Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::updateTrackBlock Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrackBlock Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPlay Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::play index 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::stop Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::play index undefined Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::startPlaybackTimer Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand stop took 16 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand stop took 4 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:20 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand status took 7 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand clear took 7 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand status took 7 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand status took 6 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac" Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: 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} Aug 26 14:40:20 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService stop Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus stop Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: No code Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: 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} Aug 26 14:40:20 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService stop Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus stop Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: No code Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 34ms Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 33ms Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:20 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:20 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:20 volumio-1 volumio[748]: info: An error occurred saving queue to disk: Error: EACCES: permission denied, open '/data/queue' Aug 26 14:40:20 volumio-1 volumio[748]: error: updateQueue error: null Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:20 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 33ms Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 32 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand add "INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac" took 32 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 4ms Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 3ms Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand play Aug 26 14:40:20 volumio-1 volumio[748]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 43ms Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:20 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:20 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 16ms Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand play took 14 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 12ms Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 11ms Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:20 volumio-1 volumio[748]: info: Aug 26 14:40:20 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:20 volumio-1 volumio[748]: info: An error occurred saving queue to disk: Error: EACCES: permission denied, open '/data/queue' Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand status took 8 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand status took 8 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand status took 7 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand status took 6 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 8 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 9 milliseconds Aug 26 14:40:20 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:20 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus stop Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:20 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:20 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:20 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:20 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:20 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:20 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:20 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:20 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 35ms Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 59ms Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 57ms Aug 26 14:40:20 volumio-1 volumio[748]: info: ------------------------------ 55ms Aug 26 14:40:42 volumio-1 volumio[748]: info: Preload queue cleared Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioReplaceandPlayItems Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::ClearQueue Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::stop Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::updateTrackBlock Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrackBlock Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::serviceStop Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::serviceStop Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::stop Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::clearPlayQueue Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::saveQueue Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushQueue Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::addQueueItems Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::addQueueItems Aug 26 14:40:42 volumio-1 volumio[748]: info: Preload queue cleared Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/02 - When You Really Loved Someone.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/02 - When You Really Loved Someone.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/03 - Perfume In The Breeze.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/03 - Perfume In The Breeze.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/04 - I Was A Flower.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/04 - I Was A Flower.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/05 - I Should've Followed You Home (ft. Gary Barlow).flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/05 - I Should've Followed You Home (ft. Gary Barlow).flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/06 - Past Forever.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/06 - Past Forever.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/07 - Dance Your Pain Away.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/07 - Dance Your Pain Away.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/08 - Bubble.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/08 - Bubble.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/09 - Back On Your Radio.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/09 - Back On Your Radio.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Adding Item to queue: music-library/INTERNAL/music/Agnetha Faltskog/A/10 - I Keep Them On The Floor Beside My Bed.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: Using cached record of: music-library/INTERNAL/music/Agnetha Faltskog/A/10 - I Keep Them On The Floor Beside My Bed.flac Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushQueue Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::saveQueue Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::updateTrackBlock Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrackBlock Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPlay Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::play index 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::stop Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::play index undefined Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::startPlaybackTimer Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand stop Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand stop took 17 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand stop took 4 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand clear Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:42 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 14 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand clear took 13 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 12 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 10 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac" Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: 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} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService stop Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus stop Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: No code Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: 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} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService stop Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus stop Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: No code Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 43ms Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 43ms Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:42 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:42 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:42 volumio-1 volumio[748]: info: An error occurred saving queue to disk: Error: EACCES: permission denied, open '/data/queue' Aug 26 14:40:42 volumio-1 volumio[748]: error: updateQueue error: null Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:42 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 36ms Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 34 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand add "INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac" took 34 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 4ms Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 3ms Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand play Aug 26 14:40:42 volumio-1 volumio[748]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 51ms Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:42 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces system playlist update Aug 26 14:40:42 volumio-1 volumio[748]: info: Ignoring MPD Status Update Aug 26 14:40:42 volumio-1 volumio[748]: info: An error occurred saving queue to disk: Error: EACCES: permission denied, open '/data/queue' Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 17ms Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand play took 15 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 14ms Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 12 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 11 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 10 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 9 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: Aug 26 14:40:42 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 5 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 4 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 4 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand status took 3 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus stop Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:42 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:42 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:42 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 48ms Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 64ms Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 62ms Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 61ms Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 45 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 46 milliseconds Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:42 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:42 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"617 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:42 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:42 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:42 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:42 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 72ms Aug 26 14:40:42 volumio-1 volumio[748]: info: ------------------------------ 71ms Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::pause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::servicePause Aug 26 14:40:53 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::servicePause Aug 26 14:40:53 volumio-1 volumio[748]: info: ControllerMpd::pause Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand pause Aug 26 14:40:53 volumio-1 volumio[748]: info: sendMpdCommand pause took 1 milliseconds Aug 26 14:40:53 volumio-1 volumio[748]: info: Aug 26 14:40:53 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:53 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:53 volumio-1 volumio[748]: info: Aug 26 14:40:53 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:53 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:53 volumio-1 volumio[748]: info: Aug 26 14:40:53 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:53 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:53 volumio-1 volumio[748]: info: sendMpdCommand status took 2 milliseconds Aug 26 14:40:53 volumio-1 volumio[748]: info: sendMpdCommand status took 1 milliseconds Aug 26 14:40:53 volumio-1 volumio[748]: info: sendMpdCommand status took 1 milliseconds Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:53 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:40:53 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:40:53 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 1 milliseconds Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:53 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:53 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:53 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":11875,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:53 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService pause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus pause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:40:53 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:53 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":11875,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:53 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService pause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus pause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:40:53 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:53 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":11875,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"695 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:53 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService pause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus pause Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:53 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:40:53 volumio-1 volumio[748]: info: ------------------------------ 24ms Aug 26 14:40:53 volumio-1 volumio[748]: info: ------------------------------ 23ms Aug 26 14:40:53 volumio-1 volumio[748]: info: ------------------------------ 23ms Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPlay Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::play index undefined Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::setConsumeUpdateService undefined Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::startPlaybackTimer Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: ControllerMpd::resume Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand play Aug 26 14:40:56 volumio-1 volumio[748]: info: sendMpdCommand play took 2 milliseconds Aug 26 14:40:56 volumio-1 volumio[748]: info: Aug 26 14:40:56 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:56 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:56 volumio-1 volumio[748]: info: Aug 26 14:40:56 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:56 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:56 volumio-1 volumio[748]: info: Aug 26 14:40:56 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:40:56 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:40:56 volumio-1 volumio[748]: info: sendMpdCommand status took 2 milliseconds Aug 26 14:40:56 volumio-1 volumio[748]: info: sendMpdCommand status took 1 milliseconds Aug 26 14:40:56 volumio-1 volumio[748]: info: sendMpdCommand status took 1 milliseconds Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:40:56 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:40:56 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:40:56 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:56 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:40:56 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12769,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"867 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:56 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus pause Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:56 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12769,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"867 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:56 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:56 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:56 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"play","position":0,"seek":12769,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"867 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:40:56 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService play Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus play Aug 26 14:40:56 volumio-1 volumio[748]: info: Received an update from plugin. extracting info from payload Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:40:56 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:40:56 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:40:56 volumio-1 volumio[748]: info: ------------------------------ 28ms Aug 26 14:40:56 volumio-1 volumio[748]: info: ------------------------------ 28ms Aug 26 14:40:56 volumio-1 volumio[748]: info: ------------------------------ 27ms Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::pause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::servicePause Aug 26 14:41:05 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::servicePause Aug 26 14:41:05 volumio-1 volumio[748]: info: ControllerMpd::pause Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand pause Aug 26 14:41:05 volumio-1 volumio[748]: info: Aug 26 14:41:05 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:41:05 volumio-1 volumio[748]: info: sendMpdCommand pause took 1 milliseconds Aug 26 14:41:05 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:41:05 volumio-1 volumio[748]: info: Aug 26 14:41:05 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:41:05 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:41:05 volumio-1 volumio[748]: info: Aug 26 14:41:05 volumio-1 volumio[748]: ---------------------------- MPD announces state update: player Aug 26 14:41:05 volumio-1 volumio[748]: info: ControllerMpd::getState Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand status Aug 26 14:41:05 volumio-1 volumio[748]: info: sendMpdCommand status took 3 milliseconds Aug 26 14:41:05 volumio-1 volumio[748]: info: sendMpdCommand status took 2 milliseconds Aug 26 14:41:05 volumio-1 volumio[748]: info: sendMpdCommand status took 1 milliseconds Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::parseState Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::sendMpdCommand playlistinfo Aug 26 14:41:05 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:41:05 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:41:05 volumio-1 volumio[748]: info: sendMpdCommand playlistinfo took 2 milliseconds Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:41:05 volumio-1 volumio[748]: verbose: ControllerMpd::parseTrackInfo Aug 26 14:41:05 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:05 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22260,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:41:05 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService pause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus pause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:41:05 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:05 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22260,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:41:05 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService pause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus pause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:41:05 volumio-1 volumio[748]: info: ControllerMpd::pushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::servicePushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:05 volumio-1 volumio[748]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":22260,"duration":211,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"846 Kbps","isStreaming":false,"title":"The One Who Loves You Now","artist":"Agnetha Faltskog","album":"A","uri":"INTERNAL/music/Agnetha Faltskog/A/01 - The One Who Loves You Now.flac","trackType":"flac"} Aug 26 14:41:05 volumio-1 volumio[748]: verbose: CURRENT POSITION 0 Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::syncState stateService pause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::syncState currentStatus pause Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::pushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreCommandRouter::volumioPushState Aug 26 14:41:05 volumio-1 volumio[748]: info: CoreStateMachine::stPlaybackTimer Aug 26 14:41:05 volumio-1 volumio[748]: info: ------------------------------ 23ms Aug 26 14:41:05 volumio-1 volumio[748]: info: ------------------------------ 21ms Aug 26 14:41:05 volumio-1 volumio[748]: info: ------------------------------ 23ms Aug 26 14:41:09 volumio-1 volumio[748]: info: CoreCommandRouter::volumioGetState Aug 26 14:41:09 volumio-1 volumio[748]: info: CorePlayQueue::getTrack 0 Aug 26 14:41:16 volumio-1 volumio[748]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 26 14:41:16 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 26 14:41:16 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 26 14:41:16 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Aug 26 14:41:16 volumio-1 volumio[748]: info: Received Get System Version Aug 26 14:41:16 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 26 14:41:24 volumio-1 volumio[748]: info: CoreCommandRouter::executeOnPlugin: wizard , openWizard Aug 26 14:41:24 volumio-1 volumio[748]: /usr/bin/touch: cannot touch '/data/wizard': Permission denied Aug 26 14:41:24 volumio-1 volumio[748]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 14:41:24 volumio-1 volumio[748]: Error: Command failed: /usr/bin/touch /data/wizard Aug 26 14:41:24 volumio-1 volumio[748]: /usr/bin/touch: cannot touch '/data/wizard': Permission denied Aug 26 14:41:24 volumio-1 volumio[748]: at checkExecSyncError (child_process.js:616:11) Aug 26 14:41:24 volumio-1 volumio[748]: at execSync (child_process.js:652:15) Aug 26 14:41:24 volumio-1 volumio[748]: at volumioWizard.openWizard (/volumio/app/plugins/miscellanea/wizard/index.js:277:5) Aug 26 14:41:24 volumio-1 volumio[748]: at CoreCommandRouter.executeOnPlugin (/volumio/app/index.js:1077:32) Aug 26 14:41:24 volumio-1 volumio[748]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1552:26) Aug 26 14:41:24 volumio-1 volumio[748]: at Socket.emit (events.js:315:20) Aug 26 14:41:24 volumio-1 volumio[748]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Aug 26 14:41:24 volumio-1 volumio[748]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { Aug 26 14:41:24 volumio-1 volumio[748]: status: 1, Aug 26 14:41:24 volumio-1 volumio[748]: signal: null, Aug 26 14:41:24 volumio-1 volumio[748]: output: [ Aug 26 14:41:24 volumio-1 volumio[748]: null, Aug 26 14:41:24 volumio-1 volumio[748]: , Aug 26 14:41:24 volumio-1 volumio[748]: Aug 26 14:41:24 volumio-1 volumio[748]: ], Aug 26 14:41:24 volumio-1 volumio[748]: pid: 1320, Aug 26 14:41:24 volumio-1 volumio[748]: stdout: , Aug 26 14:41:24 volumio-1 volumio[748]: stderr: Aug 26 14:41:24 volumio-1 volumio[748]: } Aug 26 14:41:24 volumio-1 volumio[748]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 26 14:41:24 volumio-1 sudo[1331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-26 14:40 Aug 26 14:41:24 volumio-1 sudo[1331]: 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="f8baf7ad070f376535a93fcc6590774528ddb153" VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71" VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1" VOLUMIO_BE_VERSION="0e3cf2fcfe1906c5090fab62b4cc2a5ff0069fd8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 30 Jan 2024 03:58:37 PM CET" VOLUMIO_VERSION="3.611" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="1d6379ebb89c40061afa8aee78176887"