Jan 13 21:26:09 volumio-4g volumio[1335]: verbose: New Socket.io Connection to 192.168.1.179 from 192.168.1.191 UA: Mozilla/5.0 (iPhone; CPU iPhone OS 18_7 like Mac OS X) AppleWebKit/605.1.15 (KHTML, like Gecko) Mobile/15E148 Engine version: 3 Transport: polling Total Clients: 9 Jan 13 21:26:09 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioGetState Jan 13 21:26:09 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:09 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 13 21:26:09 volumio-4g volumio[1335]: info: Listing playlists Jan 13 21:26:09 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioGetVisibleSources Jan 13 21:26:09 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 13 21:26:09 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioGetQueue Jan 13 21:26:09 volumio-4g volumio[1335]: info: CoreStateMachine::getQueue Jan 13 21:26:09 volumio-4g volumio[1335]: info: CorePlayQueue::getQueue Jan 13 21:26:13 volumio-4g volumio[2265]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:26:13 volumio-4g volumio[2265]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:26:14 volumio-4g volumio[2265]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:26:25 volumio-4g volumio[1335]: info: Preload queue cleared Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreStateMachine::ClearQueue Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreStateMachine::stop Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreStateMachine::stPlaybackTimer Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreStateMachine::updateTrackBlock Jan 13 21:26:25 volumio-4g volumio[1335]: info: CorePlayQueue::getTrackBlock Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:25 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 21:26:25 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::serviceStop Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::serviceStop Jan 13 21:26:26 volumio-4g volumio[1335]: info: ControllerMpd::stop Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::clearPlayQueue Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::saveQueue Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushQueue Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::addQueueItems Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::addQueueItems Jan 13 21:26:26 volumio-4g volumio[1335]: info: Preload queue cleared Jan 13 21:26:26 volumio-4g volumio[1335]: info: Adding Item to queue: music-library/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1 Jan 13 21:26:26 volumio-4g volumio[1335]: info: Exploding uri music-library/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1 in service mpd Jan 13 21:26:26 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:26 volumio-4g volumio[1335]: info: Jan 13 21:26:26 volumio-4g volumio[1335]: ---------------------------- MPD announces state update: player Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F01.%20Cavatina.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/01. Cavatina.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F02.%20Don%C3%AD%C2%BBt%20It%20Make%20My%20Brown%20Eyes%20Blue.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/02. Doní»t It Make My Brown Eyes Blue.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F03.%20Tennessee%20Waltz.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/03. Tennessee Waltz.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F04.%20I%20Cover%20The%20Waterfront.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/04. I Cover The Waterfront.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F05.%20Stay%20Awhile.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/05. Stay Awhile.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F06.%20As%20Time%20Goes%20By.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/06. As Time Goes By.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F07.%20Fly%20Me%20To%20The%20Moon.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/07. Fly Me To The Moon.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F08.%20Rainy%20Days%20And%20Mondays.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/08. Rainy Days And Mondays.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F09.%20Triste.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/09. Triste.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F10.%20Smoke%20Gets%20In%20Your%20Eyes.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/10. Smoke Gets In Your Eyes.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F11.%20If%20You%20Leave%20Me%20Now.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/11. If You Leave Me Now.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F12.%20There%C3%AD%C2%BBs%20A%20Kind%20Of%20Hush.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/12. Thereí»s A Kind Of Hush.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=/Audiophile%20Female%20Voices/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FAUDIOPHILE%20FEMALE%20VOICES%20CD1%2F13.%20Teach%20Me%20Tonight.wav&metadata=false Jan 13 21:26:26 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/13. Teach Me Tonight.wav Jan 13 21:26:26 volumio-4g volumio[1335]: info: sendMpdCommand stop took 381 milliseconds Jan 13 21:26:26 volumio-4g volumio[1335]: info: ControllerMpd::getState Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushQueue Jan 13 21:26:26 volumio-4g sudo[2498]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:26 volumio-4g sudo[2498]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:26 volumio-4g systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::saveQueue Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::updateTrackBlock Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrackBlock Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPlay Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::play index 0 Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::stop Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::play index undefined Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::startPlaybackTimer Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::clearAddPlayTracks USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/01. Cavatina.wav Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 21:26:26 volumio-4g systemd[1]: peppymeterbasic.service: Deactivated successfully. Jan 13 21:26:26 volumio-4g systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Jan 13 21:26:26 volumio-4g systemd[1]: peppymeterbasic.service: Consumed 22.051s CPU time. Jan 13 21:26:26 volumio-4g volumio[1335]: info: sendMpdCommand status took 233 milliseconds Jan 13 21:26:26 volumio-4g volumio[1335]: info: sendMpdCommand stop took 105 milliseconds Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::parseState Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 21:26:26 volumio-4g sudo[2498]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:26 volumio-4g volumio[1335]: info: Jan 13 21:26:26 volumio-4g volumio[1335]: ---------------------------- MPD announces system playlist update Jan 13 21:26:26 volumio-4g volumio[1335]: info: Ignoring MPD Status Update Jan 13 21:26:26 volumio-4g volumio[1335]: info: sendMpdCommand playlistinfo took 61 milliseconds Jan 13 21:26:26 volumio-4g volumio[1335]: info: sendMpdCommand clear took 62 milliseconds Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::parseTrackInfo Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand add "USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/01. Cavatina.wav" Jan 13 21:26:26 volumio-4g volumio[1335]: info: ControllerMpd::pushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::servicePushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"??","artist":"??","album":"?? . ??","uri":"USB/SanDisk/International/╘ç╥⌠ . ▓╠╟┘/01 ╢╔┐┌.wav","trackType":"wav"} Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: CURRENT POSITION 0 Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::syncState stateService stop Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::syncState currentStatus stop Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: No code Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:26 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:26 volumio-4g volumio[1335]: info: ------------------------------ 693ms Jan 13 21:26:26 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:26 volumio-4g volumio[1335]: error: updateQueue error: null Jan 13 21:26:26 volumio-4g volumio[1335]: info: Jan 13 21:26:26 volumio-4g volumio[1335]: ---------------------------- MPD announces system playlist update Jan 13 21:26:26 volumio-4g volumio[1335]: info: Ignoring MPD Status Update Jan 13 21:26:26 volumio-4g volumio[1335]: info: ------------------------------ 263ms Jan 13 21:26:26 volumio-4g volumio[1335]: info: sendMpdCommand add "USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/01. Cavatina.wav" took 223 milliseconds Jan 13 21:26:26 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand play Jan 13 21:26:27 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:27 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:27 volumio-4g sudo[2507]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:27 volumio-4g sudo[2507]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:27 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:27 volumio-4g sudo[2510]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:27 volumio-4g sudo[2510]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:27 volumio-4g sudo[2507]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:27 volumio-4g sudo[2514]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:27 volumio-4g sudo[2514]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:27 volumio-4g sudo[2514]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:27 volumio-4g volumio[1335]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 13 21:26:27 volumio-4g volumio[1335]: info: Jan 13 21:26:27 volumio-4g volumio[1335]: ---------------------------- MPD announces state update: player Jan 13 21:26:27 volumio-4g volumio[1335]: info: ------------------------------ 462ms Jan 13 21:26:27 volumio-4g volumio[1335]: info: sendMpdCommand play took 461 milliseconds Jan 13 21:26:27 volumio-4g volumio[1335]: info: ControllerMpd::getState Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Jan 13 21:26:27 volumio-4g sudo[2510]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:27 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:27 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:27 volumio-4g volumio[1335]: info: Jan 13 21:26:27 volumio-4g volumio[1335]: ---------------------------- MPD announces state update: player Jan 13 21:26:27 volumio-4g volumio[1335]: info: ControllerMpd::getState Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Jan 13 21:26:27 volumio-4g volumio[1335]: info: sendMpdCommand status took 50 milliseconds Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::parseState Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 21:26:27 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:27 volumio-4g volumio[1335]: info: sendMpdCommand status took 28 milliseconds Jan 13 21:26:27 volumio-4g volumio[1335]: info: sendMpdCommand playlistinfo took 27 milliseconds Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::parseState Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::parseTrackInfo Jan 13 21:26:27 volumio-4g volumio[1335]: info: ControllerMpd::pushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreCommandRouter::servicePushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"01. Cavatina.wav","artist":null,"album":"Audiophile Female Voices","uri":"USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/01. Cavatina.wav","trackType":"wav"} Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: CURRENT POSITION 0 Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreStateMachine::syncState stateService play Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreStateMachine::syncState currentStatus stop Jan 13 21:26:27 volumio-4g volumio[1335]: info: ------------------------------ 101ms Jan 13 21:26:27 volumio-4g volumio[1335]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: ControllerMpd::parseTrackInfo Jan 13 21:26:27 volumio-4g volumio[1335]: info: ControllerMpd::pushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreCommandRouter::servicePushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":962,"duration":240,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"01. Cavatina.wav","artist":null,"album":"Audiophile Female Voices","uri":"USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/01. Cavatina.wav","trackType":"wav"} Jan 13 21:26:27 volumio-4g volumio[1335]: verbose: CURRENT POSITION 0 Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreStateMachine::syncState stateService play Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreStateMachine::syncState currentStatus play Jan 13 21:26:27 volumio-4g volumio[1335]: info: Received an update from plugin. extracting info from payload Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:27 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:27 volumio-4g volumio[1335]: info: ------------------------------ 202ms Jan 13 21:26:27 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 13 21:26:27 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 13 21:26:27 volumio-4g sudo[2519]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 13 21:26:27 volumio-4g sudo[2519]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:27 volumio-4g sudo[2521]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 13 21:26:27 volumio-4g sudo[2521]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:27 volumio-4g systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Jan 13 21:26:27 volumio-4g volumio[1335]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 13 21:26:28 volumio-4g sudo[2519]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:28 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Started Jan 13 21:26:28 volumio-4g sudo[2521]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:28 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Started Jan 13 21:26:32 volumio-4g volumio[2542]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:26:32 volumio-4g volumio[2542]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:26:32 volumio-4g volumio[2542]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:26:39 volumio-4g volumio[1335]: info: Preload queue cleared Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::ClearQueue Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::stPlaybackTimer Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::updateTrackBlock Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrackBlock Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::serviceStop Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::serviceStop Jan 13 21:26:39 volumio-4g volumio[1335]: info: ControllerMpd::stop Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::clearPlayQueue Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::saveQueue Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushQueue Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::addQueueItems Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::addQueueItems Jan 13 21:26:39 volumio-4g volumio[1335]: info: Preload queue cleared Jan 13 21:26:39 volumio-4g volumio[1335]: info: Adding Item to queue: music-library/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA) Jan 13 21:26:39 volumio-4g volumio[1335]: info: Exploding uri music-library/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA) in service mpd Jan 13 21:26:39 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: Jan 13 21:26:39 volumio-4g volumio[1335]: ---------------------------- MPD announces state update: player Jan 13 21:26:39 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Bill%20Evans/Alone%20(833%20801-2%2C%20USA)/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FBill%20Evans%20-%20Alone%20(833%20801-2%2C%20USA)%2F01%20-%20Here_s%20That%20Rainy%20Day.wav&metadata=false Jan 13 21:26:39 volumio-4g sudo[2560]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:39 volumio-4g sudo[2560]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:39 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/01 - Here_s That Rainy Day.wav Jan 13 21:26:39 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Bill%20Evans/Alone%20(833%20801-2%2C%20USA)/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FBill%20Evans%20-%20Alone%20(833%20801-2%2C%20USA)%2F02%20-%20A%20Time%20For%20Love.wav&metadata=false Jan 13 21:26:39 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/02 - A Time For Love.wav Jan 13 21:26:39 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Bill%20Evans/Alone%20(833%20801-2%2C%20USA)/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FBill%20Evans%20-%20Alone%20(833%20801-2%2C%20USA)%2F03%20-%20Midnight%20Mood.wav&metadata=false Jan 13 21:26:39 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/03 - Midnight Mood.wav Jan 13 21:26:39 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Bill%20Evans/Alone%20(833%20801-2%2C%20USA)/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FBill%20Evans%20-%20Alone%20(833%20801-2%2C%20USA)%2F04%20-%20On%20A%20Clear%20Day%20(You%20Can%20See%20Forever).wav&metadata=false Jan 13 21:26:39 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/04 - On A Clear Day (You Can See Forever).wav Jan 13 21:26:39 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Bill%20Evans/Alone%20(833%20801-2%2C%20USA)/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FBill%20Evans%20-%20Alone%20(833%20801-2%2C%20USA)%2F05%20-%20Never%20Let%20Me%20Go.wav&metadata=false Jan 13 21:26:39 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/05 - Never Let Me Go.wav Jan 13 21:26:39 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Bill%20Evans/Alone%20(833%20801-2%2C%20USA)/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FBill%20Evans%20-%20Alone%20(833%20801-2%2C%20USA)%2F06%20-%20Medley_%20All%20the%20Things%20You%20Are-Midnight%20Mood.wav&metadata=false Jan 13 21:26:39 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/06 - Medley_ All the Things You Are-Midnight Mood.wav Jan 13 21:26:39 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Bill%20Evans/Alone%20(833%20801-2%2C%20USA)/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FBill%20Evans%20-%20Alone%20(833%20801-2%2C%20USA)%2F07%20-%20A%20Time%20for%20Love%20(2).wav&metadata=false Jan 13 21:26:39 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/07 - A Time for Love (2).wav Jan 13 21:26:39 volumio-4g volumio[1335]: info: sendMpdCommand stop took 336 milliseconds Jan 13 21:26:39 volumio-4g volumio[1335]: info: ControllerMpd::getState Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushQueue Jan 13 21:26:39 volumio-4g systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::saveQueue Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::updateTrackBlock Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrackBlock Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPlay Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::play index 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::play index undefined Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::startPlaybackTimer Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::clearAddPlayTracks USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/01 - Here_s That Rainy Day.wav Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 21:26:39 volumio-4g systemd[1]: peppymeterbasic.service: Deactivated successfully. Jan 13 21:26:39 volumio-4g systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Jan 13 21:26:39 volumio-4g systemd[1]: peppymeterbasic.service: Consumed 3.218s CPU time. Jan 13 21:26:39 volumio-4g sudo[2560]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:39 volumio-4g volumio[1335]: info: sendMpdCommand status took 201 milliseconds Jan 13 21:26:39 volumio-4g volumio[1335]: info: sendMpdCommand stop took 70 milliseconds Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::parseState Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand clear Jan 13 21:26:39 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: Jan 13 21:26:39 volumio-4g volumio[1335]: ---------------------------- MPD announces system playlist update Jan 13 21:26:39 volumio-4g volumio[1335]: info: Ignoring MPD Status Update Jan 13 21:26:39 volumio-4g volumio[1335]: info: sendMpdCommand playlistinfo took 52 milliseconds Jan 13 21:26:39 volumio-4g volumio[1335]: info: sendMpdCommand clear took 53 milliseconds Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::parseTrackInfo Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand add "USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/01 - Here_s That Rainy Day.wav" Jan 13 21:26:39 volumio-4g volumio[1335]: info: ControllerMpd::pushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::servicePushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"01. Cavatina.wav","artist":null,"album":"Audiophile Female Voices","uri":"USB/SanDisk/International/AUDIOPHILE FEMALE VOICES CD1/01. Cavatina.wav","trackType":"wav"} Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: CURRENT POSITION 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::syncState stateService stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::syncState currentStatus stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: No code Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:39 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:39 volumio-4g volumio[1335]: info: ------------------------------ 453ms Jan 13 21:26:39 volumio-4g volumio[1335]: info: touch_display: Setting screensaver timeout to 60 seconds. Jan 13 21:26:39 volumio-4g volumio[1335]: error: updateQueue error: null Jan 13 21:26:39 volumio-4g volumio[1335]: info: Jan 13 21:26:39 volumio-4g volumio[1335]: ---------------------------- MPD announces system playlist update Jan 13 21:26:39 volumio-4g volumio[1335]: info: Ignoring MPD Status Update Jan 13 21:26:39 volumio-4g volumio[1335]: info: ------------------------------ 196ms Jan 13 21:26:39 volumio-4g volumio[1335]: info: sendMpdCommand add "USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/01 - Here_s That Rainy Day.wav" took 195 milliseconds Jan 13 21:26:39 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand play Jan 13 21:26:39 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:26:39 volumio-4g volumio[1335]: info: ------------------------------ 86ms Jan 13 21:26:39 volumio-4g volumio[1335]: info: sendMpdCommand play took 85 milliseconds Jan 13 21:26:40 volumio-4g sudo[2566]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:40 volumio-4g sudo[2567]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:40 volumio-4g sudo[2567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:40 volumio-4g sudo[2566]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:40 volumio-4g sudo[2569]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:26:40 volumio-4g sudo[2567]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:40 volumio-4g sudo[2569]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:40 volumio-4g sudo[2566]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:40 volumio-4g volumio[1335]: info: Jan 13 21:26:40 volumio-4g volumio[1335]: ---------------------------- MPD announces state update: player Jan 13 21:26:40 volumio-4g volumio[1335]: info: ControllerMpd::getState Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Jan 13 21:26:40 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:40 volumio-4g volumio[1335]: info: Jan 13 21:26:40 volumio-4g volumio[1335]: ---------------------------- MPD announces state update: player Jan 13 21:26:40 volumio-4g volumio[1335]: info: ControllerMpd::getState Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand status Jan 13 21:26:40 volumio-4g volumio[1335]: info: sendMpdCommand status took 18 milliseconds Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::parseState Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 21:26:40 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:40 volumio-4g volumio[1335]: info: sendMpdCommand status took 70 milliseconds Jan 13 21:26:40 volumio-4g volumio[1335]: info: sendMpdCommand playlistinfo took 50 milliseconds Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::parseState Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::parseTrackInfo Jan 13 21:26:40 volumio-4g volumio[1335]: info: ControllerMpd::pushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreCommandRouter::servicePushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Here's That Rainy Day","artist":"Bill Evans","album":"Alone (833 801-2, USA)","uri":"USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/01 - Here_s That Rainy Day.wav","trackType":"wav"} Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: CURRENT POSITION 0 Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreStateMachine::syncState stateService play Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreStateMachine::syncState currentStatus stop Jan 13 21:26:40 volumio-4g volumio[1335]: info: ------------------------------ 139ms Jan 13 21:26:40 volumio-4g sudo[2569]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:40 volumio-4g volumio[1335]: info: sendMpdCommand playlistinfo took 61 milliseconds Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: ControllerMpd::parseTrackInfo Jan 13 21:26:40 volumio-4g volumio[1335]: info: ControllerMpd::pushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreCommandRouter::servicePushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":321,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"1411 Kbps","isStreaming":false,"title":"Here's That Rainy Day","artist":"Bill Evans","album":"Alone (833 801-2, USA)","uri":"USB/SanDisk/International/Bill Evans - Alone (833 801-2, USA)/01 - Here_s That Rainy Day.wav","trackType":"wav"} Jan 13 21:26:40 volumio-4g volumio[1335]: verbose: CURRENT POSITION 0 Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreStateMachine::syncState stateService play Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreStateMachine::syncState currentStatus play Jan 13 21:26:40 volumio-4g volumio[1335]: info: Received an update from plugin. extracting info from payload Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:26:40 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:26:40 volumio-4g volumio[1335]: info: ------------------------------ 321ms Jan 13 21:26:40 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 13 21:26:40 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status play Jan 13 21:26:40 volumio-4g sudo[2581]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 13 21:26:40 volumio-4g sudo[2581]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:40 volumio-4g sudo[2585]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start peppymeterbasic.service Jan 13 21:26:40 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Stop Jan 13 21:26:40 volumio-4g sudo[2585]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:26:40 volumio-4g systemd[1]: Started peppymeterbasic.service - peppymeterbasic Daemon. Jan 13 21:26:40 volumio-4g sudo[2581]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:40 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Started Jan 13 21:26:40 volumio-4g volumio[1335]: info: touch_display: Setting screensaver timeout to 0 seconds. Jan 13 21:26:40 volumio-4g sudo[2585]: pam_unix(sudo:session): session closed for user root Jan 13 21:26:40 volumio-4g volumio[1335]: info: peppymeterbasic Daemon Started Jan 13 21:26:45 volumio-4g volumio[2600]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:27:05 volumio-4g volumio[2600]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:27:05 volumio-4g volumio[2600]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:27:05 volumio-4g volumio[2600]: libpng warning: iCCP: known incorrect sRGB profile Jan 13 21:27:11 volumio-4g volumio[1335]: info: Preload queue cleared Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::ClearQueue Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::stop Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::stPlaybackTimer Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::updateTrackBlock Jan 13 21:27:11 volumio-4g volumio[1335]: info: CorePlayQueue::getTrackBlock Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::pushState Jan 13 21:27:11 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushState Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::serviceStop Jan 13 21:27:11 volumio-4g volumio[1335]: info: CorePlayQueue::getTrack 0 Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreCommandRouter::serviceStop Jan 13 21:27:11 volumio-4g volumio[1335]: info: ControllerMpd::stop Jan 13 21:27:11 volumio-4g volumio[1335]: verbose: ControllerMpd::sendMpdCommand stop Jan 13 21:27:11 volumio-4g volumio[1335]: info: CorePlayQueue::clearPlayQueue Jan 13 21:27:11 volumio-4g volumio[1335]: info: CorePlayQueue::saveQueue Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreCommandRouter::volumioPushQueue Jan 13 21:27:11 volumio-4g volumio[1335]: info: CoreStateMachine::addQueueItems Jan 13 21:27:11 volumio-4g volumio[1335]: info: CorePlayQueue::addQueueItems Jan 13 21:27:11 volumio-4g volumio[1335]: info: Preload queue cleared Jan 13 21:27:11 volumio-4g volumio[1335]: info: Adding Item to queue: music-library/USB/SanDisk/International/Greatest Audiophile Voices (Vol. 2) (2011-2012) [FLAC] Jan 13 21:27:11 volumio-4g volumio[1335]: info: Exploding uri music-library/USB/SanDisk/International/Greatest Audiophile Voices (Vol. 2) (2011-2012) [FLAC] in service mpd Jan 13 21:27:11 volumio-4g volumio[1335]: info: PeppyMeterBasic ---peppymeterbasic status stop Jan 13 21:27:12 volumio-4g volumio[1335]: info: Jan 13 21:27:12 volumio-4g volumio[1335]: ---------------------------- MPD announces state update: player Jan 13 21:27:12 volumio-4g sudo[2668]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop peppymeterbasic.service Jan 13 21:27:12 volumio-4g sudo[2668]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Jan 13 21:27:12 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Maci%20Miller/Greatest%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FGreatest%20Audiophile%20Voices%20(Vol.%202)%20(2011-2012)%20%5BFLAC%5D%2FVarious%20Artist%20-%20Greatest%20Audiophile%20Voices%20II.cue&metadata=false Jan 13 21:27:12 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Greatest Audiophile Voices (Vol. 2) (2011-2012) [FLAC]/Various Artist - Greatest Audiophile Voices II.cue Jan 13 21:27:12 volumio-4g volumio[1335]: info: ALBUMART /albumart?cacheid=299&web=Dani%20Thompson/Greatest%20Audiophile%20Voices%20II/extralarge&path=%2Fmnt%2FUSB%2FSanDisk%2FInternational%2FGreatest%20Audiophile%20Voices%20(Vol.%202)%20(2011-2012)%20%5BFLAC%5D%2FVarious%20Artist%20-%20Greatest%20Audiophile%20Voices%20II.cue&metadata=false Jan 13 21:27:12 volumio-4g volumio[1335]: info: URI /mnt/USB/SanDisk/International/Greatest Audiophile Voices (Vol. 2) (2011-2012) [FLAC]/Various Artist - Greatest Audiophile Voices II.cue Jan 13 21:27:12 volumio-4g volumio[1335]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 21:27:12 volumio-4g volumio[1335]: Error: Unable to resolve or reject the same promise twice Jan 13 21:27:12 volumio-4g volumio[1335]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43) Jan 13 21:27:12 volumio-4g volumio[1335]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21 Jan 13 21:27:12 volumio-4g volumio[1335]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3) Jan 13 21:27:12 volumio-4g volumio[1335]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12) Jan 13 21:27:12 volumio-4g volumio[1335]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12) Jan 13 21:27:12 volumio-4g volumio[1335]: at Socket.emit (node:events:514:28) Jan 13 21:27:12 volumio-4g volumio[1335]: at addChunk (node:internal/streams/readable:343:12) Jan 13 21:27:12 volumio-4g volumio[1335]: at readableAddChunk (node:internal/streams/readable:312:11) Jan 13 21:27:12 volumio-4g volumio[1335]: at Readable.push (node:internal/streams/readable:253:10) Jan 13 21:27:12 volumio-4g volumio[1335]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23) Jan 13 21:27:12 volumio-4g volumio[1335]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 13 21:27:12 volumio-4g systemd[1]: Stopping peppymeterbasic.service - peppymeterbasic Daemon... Jan 13 21:27:12 volumio-4g systemd[1]: peppymeterbasic.service: Deactivated successfully. Jan 13 21:27:12 volumio-4g systemd[1]: Stopped peppymeterbasic.service - peppymeterbasic Daemon. Jan 13 21:27:12 volumio-4g systemd[1]: peppymeterbasic.service: Consumed 7.762s CPU time. Jan 13 21:27:12 volumio-4g sudo[2668]: pam_unix(sudo:session): session closed for user root Jan 13 21:27:15 volumio-4g sudo[2688]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-13 21:26' Jan 13 21:27:15 volumio-4g sudo[2688]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 20:42:14 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="67fdc5f60f00b7a328ccd8c4ad441086"