-- Logs begin at Wed 2025-05-07 10:41:14 UTC, end at Fri 2025-05-09 12:53:37 UTC. -- May 09 12:52:58 volumio volumio[980]: info: CoreCommandRouter::volumioGetVisibleSources May 09 12:52:58 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 09 12:52:58 volumio volumio[980]: info: CoreCommandRouter::volumioGetState May 09 12:52:58 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:52:58 volumio volumio[980]: info: CorePlayQueue::getTrack 724 May 09 12:52:58 volumio volumio[980]: info: CoreCommandRouter::volumioGetQueue May 09 12:52:58 volumio volumio[980]: info: CoreStateMachine::getQueue May 09 12:52:58 volumio volumio[980]: info: CorePlayQueue::getQueue May 09 12:52:58 volumio volumio[980]: info: Listing playlists May 09 12:52:58 volumio sudo[4880]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:52:58 volumio sudo[4880]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:52:58 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom May 09 12:52:58 volumio sudo[4880]: pam_unix(sudo:session): session closed for user root May 09 12:52:58 volumio sudo[4886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:52:58 volumio sudo[4886]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:52:58 volumio sudo[4886]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioAddQueueItems May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::addQueueItems May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::addQueueItems May 09 12:53:02 volumio volumio[980]: info: Adding Item to queue: music-library/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF May 09 12:53:02 volumio volumio[980]: info: Exploding uri music-library/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF in service mpd May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F01-Tell%20Her%20About%20It.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F02-Grampa.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/02-Grampa.dsf May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F03-One%20Note%20Samba.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/03-One Note Samba.dsf May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F04-It's%20Only%20A%20Paper%20Moon.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/04-It's Only A Paper Moon.dsf May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F05-Theme%20From%20'Good%20King%20Bad'.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/05-Theme From 'Good King Bad'.dsf May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F06-Nica's%20Dream.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/06-Nica's Dream.dsf May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F07-S'Wonderful.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/07-S'Wonderful.dsf May 09 12:53:02 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Manhattan%20Jazz%20Quintet/Still%20Crazy/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FManhattan%20Jazz%20Quintet%20-%20Still%20Crazy%20(2015)%20SACD-DSD-DSF%2F08-Still%20Crazy%20After%20All%20These%20Years.dsf&metadata=false May 09 12:53:02 volumio volumio[980]: info: URI /mnt/USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/08-Still Crazy After All These Years.dsf May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::saveQueue May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPlay May 09 12:53:02 volumio volumio[980]: UNSET VOLATILE May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::play index 725 May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::stop May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:02 volumio volumio[980]: UNSET VOLATILE May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::stPlaybackTimer May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 724 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::serviceStop May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 724 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::serviceStop May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::stop May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio sudo[4898]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio sudo[4898]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4898]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::play index undefined May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::clearAddPlayTracks USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand clear May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:02 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand add "USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf" May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Malia & Boris Blank - Convergence.flac","artist":null,"album":null,"uri":"USB/volumio/Malia & Boris Blank - Convergence/Malia & Boris Blank - Convergence.flac","trackType":"flac"} May 09 12:53:02 volumio volumio[980]: info: CURRENT POSITION 725 May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio sudo[4908]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio volumio[980]: info: No code May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio sudo[4908]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4908]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio sudo[4912]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::pushError May 09 12:53:02 volumio volumio[980]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined May 09 12:53:02 volumio volumio[980]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) May 09 12:53:02 volumio volumio[980]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 09 12:53:02 volumio volumio[980]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 09 12:53:02 volumio volumio[980]: at process._tickCallback (internal/process/next_tick.js:180:9) May 09 12:53:02 volumio sudo[4912]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 68ms May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 64ms May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:02 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:02 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 59ms May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 3ms May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand play May 09 12:53:02 volumio sudo[4912]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:02 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 10ms May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 8ms May 09 12:53:02 volumio sudo[4921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioGetState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio sudo[4921]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4921]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: May 09 12:53:02 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":400,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Tell Her About It","artist":"Manhattan Jazz Quintet","album":"Still Crazy","uri":"USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf","trackType":"dsf"} May 09 12:53:02 volumio volumio[980]: info: CURRENT POSITION 725 May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio sudo[4935]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 32ms May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:02 volumio volumio[980]: info: sending command... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":11,"duration":400,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Tell Her About It","artist":"Manhattan Jazz Quintet","album":"Still Crazy","uri":"USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf","trackType":"dsf"} May 09 12:53:02 volumio volumio[980]: info: CURRENT POSITION 725 May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:02 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio sudo[4935]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio sudo[4935]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio sudo[4937]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio sudo[4937]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":20,"duration":400,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Tell Her About It","artist":"Manhattan Jazz Quintet","album":"Still Crazy","uri":"USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf","trackType":"dsf"} May 09 12:53:02 volumio volumio[980]: info: CURRENT POSITION 725 May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:02 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio sudo[4954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio sudo[4945]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio sudo[4954]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4945]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio sudo[4954]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 124ms May 09 12:53:02 volumio sudo[4962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 123ms May 09 12:53:02 volumio sudo[4962]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4962]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio volumio[980]: info: parsing response... May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:02 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":34,"duration":400,"samplerate":"5.64 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Tell Her About It","artist":"Manhattan Jazz Quintet","album":"Still Crazy","uri":"USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf","trackType":"dsf"} May 09 12:53:02 volumio volumio[980]: info: CURRENT POSITION 725 May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:02 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:02 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:02 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:02 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:02 volumio sudo[4981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio sudo[4981]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio volumio[980]: info: ------------------------------ 193ms May 09 12:53:02 volumio sudo[4981]: pam_unix(sudo:session): session closed for user root May 09 12:53:02 volumio sudo[4985]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:02 volumio sudo[4985]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:02 volumio sudo[4985]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioAddQueueItems May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::addQueueItems May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::addQueueItems May 09 12:53:08 volumio volumio[980]: info: Adding Item to queue: music-library/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ] May 09 12:53:08 volumio volumio[980]: info: Exploding uri music-library/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ] in service mpd May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Hanne%20Boel/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F01.%20Chance%20Of%20A%20Lifetime.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Lynni%20Treekrem/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F03.%20Ved%20Gjaetle-Bekken.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/03. Ved Gjaetle-Bekken.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Nicki%20Parrott/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F04.%20Walk%20On%20By.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/04. Walk On By.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=John%20Di%20Martino/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F05.%20Miami%20Beach%20Rumba.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/05. Miami Beach Rumba.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Halie%20Loren/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F06.%20Sisters.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/06. Sisters.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Sinne%20Eeg%20%26%20Thomas%20Fonnesbak/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F07.%20Taking%20It%20Slow.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/07. Taking It Slow.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Mighty%20Sam%20McClain/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F08.%20Here%20I%20Come%20Again.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/08. Here I Come Again.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Paolo%20Fresu%20%26%20Omar%20Sosa/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F09.%20Why.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/09. Why.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Sinne%20Eeg/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F10.%20Rain.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/10. Rain.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Kari%20Bremnes/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F11.%20En%20Rod%20For%20Alt%20Det%20Sote.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/11. En Rod For Alt Det Sote.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Stefanie%20Schlesinger/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F12.%20Fool%20On%20The%20Hill.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/12. Fool On The Hill.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Simone%20Kopmajer/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F13.%20First%20Of%20May.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/13. First Of May.dsf May 09 12:53:08 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=William%20Greco%2FLeila%20Shirvani/Master%20Superior%20Audiophile%202018%20SACD/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMaster%20%E3%80%8ASuperior%20Audiophile%20%E5%8F%91%E7%83%A7%E7%A2%9F2018%E3%80%8B%5BDSF%202.72G%20%5D%2F14.%20Yungul.dsf&metadata=false May 09 12:53:08 volumio volumio[980]: info: URI /mnt/USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/14. Yungul.dsf May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::saveQueue May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPlay May 09 12:53:08 volumio volumio[980]: UNSET VOLATILE May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::play index 733 May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::stop May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:08 volumio volumio[980]: UNSET VOLATILE May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::stPlaybackTimer May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::serviceStop May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 725 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::serviceStop May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::stop May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio sudo[4999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio sudo[4999]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::play index undefined May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio sudo[4999]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::clearAddPlayTracks USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand clear May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:08 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand add "USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf" May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Tell Her About It","artist":"Manhattan Jazz Quintet","album":"Still Crazy","uri":"USB/volumio/Manhattan Jazz Quintet - Still Crazy (2015) SACD-DSD-DSF/01-Tell Her About It.dsf","trackType":"dsf"} May 09 12:53:08 volumio volumio[980]: info: CURRENT POSITION 733 May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio sudo[5008]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio sudo[5008]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio volumio[980]: info: No code May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio sudo[5008]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio sudo[5014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::pushError May 09 12:53:08 volumio sudo[5014]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio volumio[980]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined May 09 12:53:08 volumio volumio[980]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) May 09 12:53:08 volumio volumio[980]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 09 12:53:08 volumio volumio[980]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 09 12:53:08 volumio volumio[980]: at process._tickCallback (internal/process/next_tick.js:180:9) May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 93ms May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 89ms May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:08 volumio sudo[5014]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:08 volumio sudo[5021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio sudo[5021]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio sudo[5021]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:08 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 225ms May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 165ms May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand play May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:08 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 11ms May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 8ms May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":298,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Chance Of A Lifetime","artist":"Hanne Boel","album":"Master Superior Audiophile 2018 SACD","uri":"USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf","trackType":"dsf"} May 09 12:53:08 volumio volumio[980]: info: CURRENT POSITION 733 May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 34ms May 09 12:53:08 volumio volumio[980]: info: May 09 12:53:08 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":46,"duration":298,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Chance Of A Lifetime","artist":"Hanne Boel","album":"Master Superior Audiophile 2018 SACD","uri":"USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf","trackType":"dsf"} May 09 12:53:08 volumio volumio[980]: info: CURRENT POSITION 733 May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:08 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio sudo[5035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio sudo[5035]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio sudo[5035]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio sudo[5039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 70ms May 09 12:53:08 volumio sudo[5039]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio sudo[5045]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio sudo[5039]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio sudo[5045]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:08 volumio volumio[980]: info: sending command... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":110,"duration":298,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Chance Of A Lifetime","artist":"Hanne Boel","album":"Master Superior Audiophile 2018 SACD","uri":"USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf","trackType":"dsf"} May 09 12:53:08 volumio volumio[980]: info: CURRENT POSITION 733 May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:08 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:08 volumio sudo[5045]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio sudo[5062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 110ms May 09 12:53:08 volumio volumio[980]: info: parsing response... May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:08 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":429,"duration":298,"samplerate":"2.82 MHz","bitdepth":"1 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Chance Of A Lifetime","artist":"Hanne Boel","album":"Master Superior Audiophile 2018 SACD","uri":"USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf","trackType":"dsf"} May 09 12:53:08 volumio volumio[980]: info: CURRENT POSITION 733 May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:08 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio sudo[5062]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio sudo[5064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio sudo[5064]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio sudo[5062]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:08 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:08 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:08 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:08 volumio sudo[5064]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio sudo[5076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio volumio[980]: info: ------------------------------ 119ms May 09 12:53:08 volumio sudo[5083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:08 volumio sudo[5076]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio sudo[5083]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:08 volumio sudo[5076]: pam_unix(sudo:session): session closed for user root May 09 12:53:08 volumio sudo[5083]: pam_unix(sudo:session): session closed for user root May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::volumioAddQueueItems May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::addQueueItems May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::addQueueItems May 09 12:53:14 volumio volumio[980]: info: Adding Item to queue: music-library/USB/volumio/Matisse-Demo-Disc [WAV+CUE] May 09 12:53:14 volumio volumio[980]: info: Exploding uri music-library/USB/volumio/Matisse-Demo-Disc [WAV+CUE] in service mpd May 09 12:53:14 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=//extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FMatisse-Demo-Disc%20%5BWAV%2BCUE%5D%2FCDImage.wav&metadata=false May 09 12:53:14 volumio volumio[980]: info: URI /mnt/USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::saveQueue May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::volumioPlay May 09 12:53:14 volumio volumio[980]: UNSET VOLATILE May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::play index 746 May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::stop May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:14 volumio volumio[980]: UNSET VOLATILE May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::stPlaybackTimer May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::serviceStop May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 733 May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::serviceStop May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::stop May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio sudo[5099]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:14 volumio sudo[5099]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:14 volumio sudo[5099]: pam_unix(sudo:session): session closed for user root May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::play index undefined May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::clearAddPlayTracks USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand clear May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:14 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand add "USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav" May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:14 volumio volumio[980]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Chance Of A Lifetime","artist":"Hanne Boel","album":"Master Superior Audiophile 2018 SACD","uri":"USB/volumio/Master 《Superior Audiophile 发烧碟2018》[DSF 2.72G ]/01. Chance Of A Lifetime.dsf","trackType":"dsf"} May 09 12:53:14 volumio volumio[980]: info: CURRENT POSITION 746 May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:14 volumio sudo[5108]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:14 volumio volumio[980]: info: No code May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:14 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:14 volumio sudo[5108]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:14 volumio sudo[5108]: pam_unix(sudo:session): session closed for user root May 09 12:53:14 volumio sudo[5111]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::pushError May 09 12:53:14 volumio volumio[980]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined May 09 12:53:14 volumio volumio[980]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) May 09 12:53:14 volumio volumio[980]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 09 12:53:14 volumio volumio[980]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 09 12:53:14 volumio volumio[980]: at process._tickCallback (internal/process/next_tick.js:180:9) May 09 12:53:14 volumio sudo[5111]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:14 volumio volumio[980]: info: ------------------------------ 71ms May 09 12:53:14 volumio volumio[980]: info: ------------------------------ 67ms May 09 12:53:14 volumio sudo[5117]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:14 volumio sudo[5111]: pam_unix(sudo:session): session closed for user root May 09 12:53:14 volumio sudo[5117]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:14 volumio sudo[5117]: pam_unix(sudo:session): session closed for user root May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:14 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:14 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:14 volumio volumio[980]: info: ------------------------------ 90ms May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: ------------------------------ 2ms May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand play May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:14 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:14 volumio volumio[980]: info: ------------------------------ 11ms May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: ------------------------------ 8ms May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: May 09 12:53:14 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: parsing response... May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:14 volumio volumio[980]: info: sending command... May 09 12:53:14 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:14 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:14 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3531,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav","trackType":"wav"} May 09 12:53:15 volumio volumio[980]: info: CURRENT POSITION 746 May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:15 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3531,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav","trackType":"wav"} May 09 12:53:15 volumio volumio[980]: info: CURRENT POSITION 746 May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:15 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:15 volumio sudo[5135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:15 volumio sudo[5135]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:15 volumio sudo[5135]: pam_unix(sudo:session): session closed for user root May 09 12:53:15 volumio volumio[980]: info: sending command... May 09 12:53:15 volumio volumio[980]: info: ------------------------------ 70ms May 09 12:53:15 volumio volumio[980]: info: ------------------------------ 69ms May 09 12:53:15 volumio sudo[5142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:15 volumio volumio[980]: info: parsing response... May 09 12:53:15 volumio volumio[980]: info: parsing response... May 09 12:53:15 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:15 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:15 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:15 volumio sudo[5142]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3531,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav","trackType":"wav"} May 09 12:53:15 volumio volumio[980]: info: CURRENT POSITION 746 May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:15 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:15 volumio sudo[5142]: pam_unix(sudo:session): session closed for user root May 09 12:53:15 volumio sudo[5146]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:15 volumio sudo[5146]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:15 volumio sudo[5146]: pam_unix(sudo:session): session closed for user root May 09 12:53:15 volumio sudo[5156]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:15 volumio sudo[5156]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:15 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3531,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav","trackType":"wav"} May 09 12:53:15 volumio volumio[980]: info: CURRENT POSITION 746 May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:15 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio sudo[5156]: pam_unix(sudo:session): session closed for user root May 09 12:53:15 volumio sudo[5168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:15 volumio sudo[5168]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:15 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:15 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:15 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:15 volumio sudo[5168]: pam_unix(sudo:session): session closed for user root May 09 12:53:15 volumio sudo[5177]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:15 volumio volumio[980]: info: ------------------------------ 157ms May 09 12:53:15 volumio volumio[980]: info: ------------------------------ 155ms May 09 12:53:15 volumio sudo[5177]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:15 volumio sudo[5182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:15 volumio sudo[5177]: pam_unix(sudo:session): session closed for user root May 09 12:53:15 volumio sudo[5182]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:15 volumio sudo[5182]: pam_unix(sudo:session): session closed for user root May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::volumioAddQueueItems May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::addQueueItems May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::addQueueItems May 09 12:53:24 volumio volumio[980]: info: Adding Item to queue: music-library/USB/volumio/Jean-Louis LeRoux - Paul Chihara The Tempest May 09 12:53:24 volumio volumio[980]: info: Exploding uri music-library/USB/volumio/Jean-Louis LeRoux - Paul Chihara The Tempest in service mpd May 09 12:53:24 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=Jean-Louis%20LeRoux/Paul%20ChiharaThe%20Tempest%20-%20RR%201988/extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FJean-Louis%20LeRoux%20-%20Paul%20Chihara%20The%20Tempest%2FJean-Louis%20LeRoux%20-%20Paul%20ChiharaThe%20Tempest.flac&metadata=false May 09 12:53:24 volumio volumio[980]: info: URI /mnt/USB/volumio/Jean-Louis LeRoux - Paul Chihara The Tempest/Jean-Louis LeRoux - Paul ChiharaThe Tempest.flac May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::saveQueue May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::volumioPlay May 09 12:53:24 volumio volumio[980]: UNSET VOLATILE May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::play index 747 May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::stop May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:24 volumio volumio[980]: UNSET VOLATILE May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::stPlaybackTimer May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::serviceStop May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 746 May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::serviceStop May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::stop May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio sudo[5198]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:24 volumio sudo[5198]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:24 volumio sudo[5198]: pam_unix(sudo:session): session closed for user root May 09 12:53:24 volumio volumio[980]: info: May 09 12:53:24 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::play index undefined May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 747 May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 747 May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::clearAddPlayTracks USB/volumio/Jean-Louis LeRoux - Paul Chihara The Tempest/Jean-Louis LeRoux - Paul ChiharaThe Tempest.flac May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: May 09 12:53:24 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand clear May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: May 09 12:53:24 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:24 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand add "USB/volumio/Jean-Louis LeRoux - Paul Chihara The Tempest/Jean-Louis LeRoux - Paul ChiharaThe Tempest.flac" May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 747 May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 747 May 09 12:53:24 volumio volumio[980]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.wav","artist":null,"album":null,"uri":"USB/volumio/Matisse-Demo-Disc [WAV+CUE]/CDImage.wav","trackType":"wav"} May 09 12:53:24 volumio volumio[980]: info: CURRENT POSITION 747 May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 747 May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:24 volumio sudo[5207]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:24 volumio sudo[5207]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:24 volumio volumio[980]: info: No code May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:24 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:24 volumio volumio[980]: info: CorePlayQueue::getTrack 747 May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:24 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:24 volumio sudo[5207]: pam_unix(sudo:session): session closed for user root May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::pushError May 09 12:53:24 volumio volumio[980]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined May 09 12:53:24 volumio volumio[980]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) May 09 12:53:24 volumio volumio[980]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 09 12:53:24 volumio volumio[980]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 09 12:53:24 volumio volumio[980]: at process._tickCallback (internal/process/next_tick.js:180:9) May 09 12:53:24 volumio sudo[5211]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:24 volumio volumio[980]: info: ------------------------------ 64ms May 09 12:53:24 volumio volumio[980]: info: ------------------------------ 60ms May 09 12:53:24 volumio volumio[980]: info: May 09 12:53:24 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:24 volumio sudo[5217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:24 volumio sudo[5211]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:24 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:24 volumio volumio[980]: info: May 09 12:53:24 volumio volumio[980]: info: May 09 12:53:24 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:24 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:24 volumio volumio[980]: info: ------------------------------ 60ms May 09 12:53:24 volumio volumio[980]: info: parsing response... May 09 12:53:24 volumio volumio[980]: info: ------------------------------ 4ms May 09 12:53:24 volumio volumio[980]: info: ControllerMpd::sendMpdCommand play May 09 12:53:24 volumio volumio[980]: info: sending command... May 09 12:53:24 volumio volumio[980]: info: May 09 12:53:24 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:28 volumio systemd-journal[191]: Suppressed 179 messages from /system.slice/volumio.service May 09 12:53:28 volumio sudo[5297]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:28 volumio sudo[5297]: pam_unix(sudo:session): session closed for user root May 09 12:53:28 volumio volumio[980]: info: May 09 12:53:28 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:28 volumio volumio[980]: info: parsing response... May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::play index undefined May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:28 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer May 09 12:53:28 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::clearAddPlayTracks USB/volumio/Jazz.At.The.Pawnshop.3.-.Good.Vibes/CDImage.flac May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:28 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio volumio[980]: info: May 09 12:53:28 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:28 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio volumio[980]: info: parsing response... May 09 12:53:28 volumio volumio[980]: info: parsing response... May 09 12:53:28 volumio volumio[980]: info: parsing response... May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::sendMpdCommand clear May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:28 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio volumio[980]: info: May 09 12:53:28 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:28 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:28 volumio volumio[980]: info: parsing response... May 09 12:53:28 volumio volumio[980]: info: parsing response... May 09 12:53:28 volumio volumio[980]: info: parsing response... May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::sendMpdCommand add "USB/volumio/Jazz.At.The.Pawnshop.3.-.Good.Vibes/CDImage.flac" May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:28 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:28 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:28 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:28 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:28 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:28 volumio volumio[980]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"Farewell Pas de Deux","artist":"Jean-Louis LeRoux","album":"Paul ChiharaThe Tempest - RR 1988","uri":"USB/volumio/Jean-Louis LeRoux - Paul Chihara The Tempest/Jean-Louis LeRoux - Paul ChiharaThe Tempest.flac","trackType":"flac"} May 09 12:53:28 volumio volumio[980]: info: CURRENT POSITION 748 May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:28 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:28 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:28 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:28 volumio sudo[5306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:28 volumio volumio[980]: info: No code May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:28 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:28 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:28 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:28 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:28 volumio sudo[5306]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:28 volumio sudo[5306]: pam_unix(sudo:session): session closed for user root May 09 12:53:28 volumio sudo[5310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:28 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio volumio[980]: info: ControllerMpd::pushError May 09 12:53:28 volumio volumio[980]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined May 09 12:53:28 volumio volumio[980]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) May 09 12:53:28 volumio volumio[980]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 09 12:53:28 volumio volumio[980]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 09 12:53:28 volumio volumio[980]: at process._tickCallback (internal/process/next_tick.js:180:9) May 09 12:53:28 volumio sudo[5310]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:28 volumio volumio[980]: info: ------------------------------ 71ms May 09 12:53:28 volumio volumio[980]: info: ------------------------------ 57ms May 09 12:53:28 volumio volumio[980]: info: May 09 12:53:28 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:28 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:28 volumio volumio[980]: info: May 09 12:53:28 volumio sudo[5318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:28 volumio volumio[980]: info: May 09 12:53:28 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:28 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 58ms May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 3ms May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand play May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:28 volumio sudo[5310]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio sudo[5318]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio volumio[980]: info: May 09 12:53:29 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:29 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 10ms May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 7ms May 09 12:53:29 volumio sudo[5318]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio volumio[980]: info: May 09 12:53:29 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: May 09 12:53:29 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: May 09 12:53:29 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: May 09 12:53:29 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":3313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.3.-.Good.Vibes/CDImage.flac","trackType":"flac"} May 09 12:53:29 volumio volumio[980]: info: CURRENT POSITION 748 May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:29 volumio sudo[5333]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:29 volumio sudo[5333]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":3313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.3.-.Good.Vibes/CDImage.flac","trackType":"flac"} May 09 12:53:29 volumio volumio[980]: info: CURRENT POSITION 748 May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:29 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:29 volumio sudo[5333]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio sudo[5337]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:29 volumio sudo[5337]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 65ms May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 63ms May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:29 volumio volumio[980]: info: sending command... May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":3313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.3.-.Good.Vibes/CDImage.flac","trackType":"flac"} May 09 12:53:29 volumio volumio[980]: info: CURRENT POSITION 748 May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:29 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:29 volumio sudo[5337]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio sudo[5346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:29 volumio sudo[5346]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio sudo[5354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:29 volumio sudo[5346]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:29 volumio sudo[5354]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 103ms May 09 12:53:29 volumio sudo[5362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:29 volumio sudo[5354]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio volumio[980]: info: parsing response... May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:29 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":580,"duration":3313,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.3.-.Good.Vibes/CDImage.flac","trackType":"flac"} May 09 12:53:29 volumio volumio[980]: info: CURRENT POSITION 748 May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:29 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:29 volumio sudo[5362]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio sudo[5362]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:29 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:29 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:29 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:29 volumio sudo[5375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:29 volumio sudo[5375]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio volumio[980]: info: ------------------------------ 145ms May 09 12:53:29 volumio sudo[5375]: pam_unix(sudo:session): session closed for user root May 09 12:53:29 volumio sudo[5381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:29 volumio sudo[5381]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:29 volumio sudo[5381]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioAddQueueItems May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::addQueueItems May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::addQueueItems May 09 12:53:34 volumio volumio[980]: info: Adding Item to queue: music-library/USB/volumio/Jazz.At.The.Pawnshop.2 May 09 12:53:34 volumio volumio[980]: info: Exploding uri music-library/USB/volumio/Jazz.At.The.Pawnshop.2 in service mpd May 09 12:53:34 volumio volumio[980]: info: ALBUMART /albumart?cacheid=369&web=//extralarge&path=%2Fmnt%2FUSB%2Fvolumio%2FJazz.At.The.Pawnshop.2%2FCDImage.flac&metadata=false May 09 12:53:34 volumio volumio[980]: info: URI /mnt/USB/volumio/Jazz.At.The.Pawnshop.2/CDImage.flac May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::saveQueue May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushQueue May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPlay May 09 12:53:34 volumio volumio[980]: UNSET VOLATILE May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::play index 749 May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::stop May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:34 volumio volumio[980]: UNSET VOLATILE May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::stPlaybackTimer May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::updateTrackBlock May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrackBlock May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::serviceStop May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 748 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::serviceStop May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::stop May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio sudo[5397]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio sudo[5397]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio sudo[5397]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::play index undefined May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::setConsumeUpdateService undefined May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::startPlaybackTimer May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::clearAddPlayTracks USB/volumio/Jazz.At.The.Pawnshop.2/CDImage.flac May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand stop May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand clear May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:34 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand add "USB/volumio/Jazz.At.The.Pawnshop.2/CDImage.flac" May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.3.-.Good.Vibes/CDImage.flac","trackType":"flac"} May 09 12:53:34 volumio volumio[980]: info: CURRENT POSITION 749 May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState stateService stop May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5406]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio volumio[980]: info: No code May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5406]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio sudo[5410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::pushError May 09 12:53:34 volumio volumio[980]: info: message=Cannot read property 'split' of undefined, stack=TypeError: Cannot read property 'split' of undefined May 09 12:53:34 volumio volumio[980]: at Promise._successFn (/volumio/app/plugins/music_service/mpd/index.js:295:72) May 09 12:53:34 volumio volumio[980]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) May 09 12:53:34 volumio volumio[980]: at _combinedTickCallback (internal/process/next_tick.js:131:7) May 09 12:53:34 volumio volumio[980]: at process._tickCallback (internal/process/next_tick.js:180:9) May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 60ms May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 54ms May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:34 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:34 volumio sudo[5415]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 51ms May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand play May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces system playlist update May 09 12:53:34 volumio volumio[980]: info: Ignoring MPD Status Update May 09 12:53:34 volumio sudo[5410]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio sudo[5415]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 11ms May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 9ms May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 8ms May 09 12:53:34 volumio sudo[5410]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio sudo[5415]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: May 09 12:53:34 volumio volumio[980]: ---------------------------- MPD announces state update: player May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::getState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand status May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseState May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::sendMpdCommand playlistinfo May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":3614,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.2/CDImage.flac","trackType":"flac"} May 09 12:53:34 volumio volumio[980]: info: CURRENT POSITION 749 May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus stop May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio sudo[5433]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":441,"duration":3614,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.2/CDImage.flac","trackType":"flac"} May 09 12:53:34 volumio volumio[980]: info: CURRENT POSITION 749 May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:34 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5433]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio sudo[5437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio sudo[5437]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio volumio[980]: info: sending command... May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 63ms May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 62ms May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: parsing response... May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::parseTrackInfo May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:34 volumio sudo[5437]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio sudo[5447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3614,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.2/CDImage.flac","trackType":"flac"} May 09 12:53:34 volumio volumio[980]: info: CURRENT POSITION 749 May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:34 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5447]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5447]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio sudo[5455]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio volumio[980]: info: ControllerMpd::pushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::servicePushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: STATE SERVICE {"status":"play","position":0,"seek":464,"duration":3614,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"isStreaming":false,"title":"CDImage.flac","artist":null,"album":null,"uri":"USB/volumio/Jazz.At.The.Pawnshop.2/CDImage.flac","trackType":"flac"} May 09 12:53:34 volumio volumio[980]: info: CURRENT POSITION 749 May 09 12:53:34 volumio sudo[5455]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState stateService play May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::syncState currentStatus play May 09 12:53:34 volumio volumio[980]: info: Received an update from plugin. extracting info from payload May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::pushState May 09 12:53:34 volumio volumio[980]: info: CoreStateMachine::getState May 09 12:53:34 volumio volumio[980]: info: CorePlayQueue::getTrack 749 May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::volumioPushState May 09 12:53:34 volumio volumio[980]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 09 12:53:34 volumio sudo[5455]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio sudo[5464]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio sudo[5469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio sudo[5464]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 131ms May 09 12:53:34 volumio volumio[980]: info: ------------------------------ 129ms May 09 12:53:34 volumio sudo[5469]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio sudo[5479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 09 12:53:34 volumio sudo[5479]: pam_unix(sudo:session): session opened for user root by (uid=0) May 09 12:53:34 volumio sudo[5469]: pam_unix(sudo:session): session closed for user root May 09 12:53:34 volumio sudo[5479]: pam_unix(sudo:session): session closed for user root May 09 12:53:37 volumio volumio[980]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 12:53:37 volumio volumio[980]: { Error: connect ETIMEDOUT 128.242.240.85:443 May 09 12:53:37 volumio volumio[980]: at Object._errnoException (util.js:1022:11) May 09 12:53:37 volumio volumio[980]: at _exceptionWithHostPort (util.js:1044:20) May 09 12:53:37 volumio volumio[980]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1198:14) May 09 12:53:37 volumio volumio[980]: code: 'ETIMEDOUT', May 09 12:53:37 volumio volumio[980]: errno: 'ETIMEDOUT', May 09 12:53:37 volumio volumio[980]: syscall: 'connect', May 09 12:53:37 volumio volumio[980]: address: '128.242.240.85', May 09 12:53:37 volumio volumio[980]: port: 443 } May 09 12:53:37 volumio volumio[980]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 09 12:53:37 volumio sudo[5504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-09 12:52 May 09 12:53:37 volumio sudo[5504]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 8 (jessie)" NAME="Raspbian GNU/Linux" VERSION_ID="8" VERSION="8 (jessie)" 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="80e3a7415791a01dac7cd7cc2cc0a3d3fc65ba9d" VOLUMIO_FE_VERSION="" VOLUMIO_BE_VERSION="e32e25d68d93383fe73e2a451c032b2661c71694" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jan 20 19:41:22 CET 2020" VOLUMIO_VERSION="2.699" VOLUMIO_HARDWARE="pi" VOLUMIO_HASH="5faefe8928fcf34b6263aec4aa82825a"