Jan 10 12:23:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
Jan 10 12:23:02 volumio volumio[1279]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
Jan 10 12:23:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
Jan 10 12:23:02 volumio volumio[1279]: info: Received Get System Version
Jan 10 12:23:02 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jan 10 12:23:03 volumio volumio[1279]: info: Received Get System Info
Jan 10 12:23:03 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jan 10 12:23:03 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jan 10 12:23:03 volumio volumio[1279]: info: Discovery: Getting this device information
Jan 10 12:23:03 volumio volumio[1279]: info: CoreCommandRouter::volumioGetState
Jan 10 12:23:03 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:03 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPlay
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::play index undefined
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::startPlaybackTimer
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::clearAddPlayTracks USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand stop
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand stop took 2 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand clear
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces system playlist update
Jan 10 12:23:16 volumio volumio[1279]: info: Ignoring MPD Status Update
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand clear took 2 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand add "USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac"
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces system playlist update
Jan 10 12:23:16 volumio volumio[1279]: info: Ignoring MPD Status Update
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces system playlist update
Jan 10 12:23:16 volumio volumio[1279]: info: Ignoring MPD Status Update
Jan 10 12:23:16 volumio volumio[1279]: error: updateQueue error: null
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces system playlist update
Jan 10 12:23:16 volumio volumio[1279]: info: Ignoring MPD Status Update
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 7ms
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand add "USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac" took 5 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 6ms
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 5ms
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand play
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces system playlist update
Jan 10 12:23:16 volumio volumio[1279]: info: Ignoring MPD Status Update
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces system playlist update
Jan 10 12:23:16 volumio volumio[1279]: info: Ignoring MPD Status Update
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 8ms
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand play took 5 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 4ms
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 3ms
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces state update: player
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::getState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces state update: player
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::getState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces state update: player
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::getState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status
Jan 10 12:23:16 volumio kernel: bcm2835-i2s fe203000.i2s: I2S SYNC error!
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces state update: player
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::getState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces state update: player
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::getState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status
Jan 10 12:23:16 volumio volumio[1279]: info:
Jan 10 12:23:16 volumio volumio[1279]: ---------------------------- MPD announces state update: player
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand status took 10 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand status took 9 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand status took 7 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::getState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand status
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand status took 10 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand status took 10 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand status took 6 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseState
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::servicePushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Lovely Day","artist":"Bill Withers","album":"Greatest Ever! Smooth The Definitive Collection","uri":"USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac","trackType":"flac"}
Jan 10 12:23:16 volumio volumio[1279]: verbose: CURRENT POSITION 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus stop
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::servicePushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":45,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"101 Kbps","isStreaming":false,"title":"Lovely Day","artist":"Bill Withers","album":"Greatest Ever! Smooth The Definitive Collection","uri":"USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac","trackType":"flac"}
Jan 10 12:23:16 volumio volumio[1279]: verbose: CURRENT POSITION 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play
Jan 10 12:23:16 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::servicePushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"669 Kbps","isStreaming":false,"title":"Lovely Day","artist":"Bill Withers","album":"Greatest Ever! Smooth The Definitive Collection","uri":"USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac","trackType":"flac"}
Jan 10 12:23:16 volumio volumio[1279]: verbose: CURRENT POSITION 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play
Jan 10 12:23:16 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 47ms
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 61ms
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 58ms
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 41 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 42 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: info: sendMpdCommand playlistinfo took 41 milliseconds
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo
Jan 10 12:23:16 volumio volumio[1279]: verbose: ControllerMpd::parseTrackInfo
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::servicePushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"774 Kbps","isStreaming":false,"title":"Lovely Day","artist":"Bill Withers","album":"Greatest Ever! Smooth The Definitive Collection","uri":"USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac","trackType":"flac"}
Jan 10 12:23:16 volumio volumio[1279]: verbose: CURRENT POSITION 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play
Jan 10 12:23:16 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::servicePushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"774 Kbps","isStreaming":false,"title":"Lovely Day","artist":"Bill Withers","album":"Greatest Ever! Smooth The Definitive Collection","uri":"USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac","trackType":"flac"}
Jan 10 12:23:16 volumio volumio[1279]: verbose: CURRENT POSITION 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play
Jan 10 12:23:16 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: ControllerMpd::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::servicePushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":248,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"774 Kbps","isStreaming":false,"title":"Lovely Day","artist":"Bill Withers","album":"Greatest Ever! Smooth The Definitive Collection","uri":"USB/FP_2T/Musica/Music Is Life/Easy/VA - Greatest Ever Smooth the Definitive Collection (2006)/101-bill_withers-lovely_day.flac","trackType":"flac"}
Jan 10 12:23:16 volumio volumio[1279]: verbose: CURRENT POSITION 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState stateService play
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::syncState currentStatus play
Jan 10 12:23:16 volumio volumio[1279]: info: Received an update from plugin. extracting info from payload
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:23:16 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:23:16 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 93ms
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 91ms
Jan 10 12:23:16 volumio volumio[1279]: info: ------------------------------ 90ms
Jan 10 12:23:54 volumio volumio[1279]: info: CoreCommandRouter::volumioGetQueue
Jan 10 12:23:54 volumio volumio[1279]: info: CoreStateMachine::getQueue
Jan 10 12:23:54 volumio volumio[1279]: info: CorePlayQueue::getQueue
Jan 10 12:23:55 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 10 12:23:55 volumio volumio[1279]: info: CURURI: music-library
Jan 10 12:23:55 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:04 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 10 12:24:04 volumio volumio[1279]: info: CURURI: music-library/USB
Jan 10 12:24:04 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:06 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 10 12:24:06 volumio volumio[1279]: info: CURURI: music-library/USB/FP_2T
Jan 10 12:24:06 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:06 volumio volumio[1279]: info: Preloading song: music-library/USB/FP_2T/Untitled.mp4
Jan 10 12:24:06 volumio volumio[1279]: info: Exploding uri music-library/USB/FP_2T/Untitled.mp4 in service mpd
Jan 10 12:24:06 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=//extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FUntitled.mp4&metadata=false
Jan 10 12:24:06 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Untitled.mp4
Jan 10 12:24:08 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 10 12:24:08 volumio volumio[1279]: info: CURURI: music-library/USB/FP_2T/Musica
Jan 10 12:24:08 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:10 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 10 12:24:10 volumio volumio[1279]: info: CURURI: music-library/USB/FP_2T/Musica/Music Is Life
Jan 10 12:24:10 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:29 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri
Jan 10 12:24:29 volumio volumio[1279]: info: CURURI: music-library/USB/FP_2T/Musica/Music Is Life/Electronic
Jan 10 12:24:29 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:38 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:38 volumio volumio[1279]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::ClearQueue
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::stop
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::stPlaybackTimer
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::updateTrackBlock
Jan 10 12:24:38 volumio volumio[1279]: info: CorePlayQueue::getTrackBlock
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::pushState
Jan 10 12:24:38 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:24:38 volumio volumio[1279]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 10 12:24:38 volumio volumio[1279]: info: CoreCommandRouter::volumioPushState
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::serviceStop
Jan 10 12:24:38 volumio volumio[1279]: info: CorePlayQueue::getTrack 0
Jan 10 12:24:38 volumio volumio[1279]: info: CoreCommandRouter::serviceStop
Jan 10 12:24:38 volumio volumio[1279]: info: ControllerMpd::stop
Jan 10 12:24:38 volumio volumio[1279]: verbose: ControllerMpd::sendMpdCommand stop
Jan 10 12:24:38 volumio volumio[1279]: info: CorePlayQueue::clearPlayQueue
Jan 10 12:24:38 volumio volumio[1279]: info: CorePlayQueue::saveQueue
Jan 10 12:24:38 volumio volumio[1279]: info: CoreCommandRouter::volumioPushQueue
Jan 10 12:24:38 volumio volumio[1279]: info: CoreStateMachine::addQueueItems
Jan 10 12:24:38 volumio volumio[1279]: info: CorePlayQueue::addQueueItems
Jan 10 12:24:38 volumio volumio[1279]: info: Preload queue cleared
Jan 10 12:24:38 volumio volumio[1279]: info: Adding Item to queue: music-library/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)
Jan 10 12:24:38 volumio volumio[1279]: info: Exploding uri music-library/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010) in service mpd
Jan 10 12:24:38 volumio volumio[1279]: info:
Jan 10 12:24:38 volumio volumio[1279]: ---------------------------- MPD announces state update: player
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F01.%20Rockets%20_%20Atomic.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/01. Rockets _ Atomic.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F02.%20Rockets%20_%20Some%20Other%20Place%2C%20Some%20Other%20Time.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/02. Rockets _ Some Other Place, Some Other Time.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F03.%20Rockets%20_%20Star%20Vision.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/03. Rockets _ Star Vision.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F04.%20Rockets%20_%20Run%20To%20The%20Stars.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/04. Rockets _ Run To The Stars.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F05.%20Rockets%20_%20Future%20Game.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/05. Rockets _ Future Game.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F06.%20Rockets%20_%20Light%20Speed%20Junky.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/06. Rockets _ Light Speed Junky.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F07.%20Rockets%20_%20The%20Martian%20Way.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/07. Rockets _ The Martian Way.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2F08.%20Rockets%20_%20Radio%20Station.flac&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/08. Rockets _ Radio Station.flac
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2FRockets%20-%20Atomic-new.cue&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/Rockets - Atomic-new.cue
Jan 10 12:24:38 volumio volumio[1279]: info: ALBUMART /albumart?cacheid=794&web=Rockets/Atomic/extralarge&path=%2Fmnt%2FUSB%2FFP_2T%2FMusica%2FMusic%20Is%20Life%2FElectronic%2FRockets%20-%20The%20Story%20%5B7CD%5D%20(2010)%2FRockets%20-%20Atomic%20(1982)%2FRockets%20-%20Atomic-new.cue&metadata=false
Jan 10 12:24:38 volumio volumio[1279]: info: URI /mnt/USB/FP_2T/Musica/Music Is Life/Electronic/Rockets - The Story [7CD] (2010)/Rockets - Atomic (1982)/Rockets - Atomic-new.cue
Jan 10 12:24:38 volumio volumio[1279]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 10 12:24:38 volumio volumio[1279]: Error: Unable to resolve or reject the same promise twice
Jan 10 12:24:38 volumio volumio[1279]: at Promise.resolve (/volumio/node_modules/kew/kew.js:140:43)
Jan 10 12:24:38 volumio volumio[1279]: at /volumio/app/plugins/music_service/mpd/index.js:2587:21
Jan 10 12:24:38 volumio volumio[1279]: at MpdClient.handleMessage (/volumio/app/plugins/music_service/mpd/lib/mpd.js:77:3)
Jan 10 12:24:38 volumio volumio[1279]: at MpdClient.receive (/volumio/app/plugins/music_service/mpd/lib/mpd.js:68:12)
Jan 10 12:24:38 volumio volumio[1279]: at Socket. (/volumio/app/plugins/music_service/mpd/lib/mpd.js:43:12)
Jan 10 12:24:38 volumio volumio[1279]: at Socket.emit (node:events:514:28)
Jan 10 12:24:38 volumio volumio[1279]: at addChunk (node:internal/streams/readable:343:12)
Jan 10 12:24:38 volumio volumio[1279]: at readableAddChunk (node:internal/streams/readable:312:11)
Jan 10 12:24:38 volumio volumio[1279]: at Readable.push (node:internal/streams/readable:253:10)
Jan 10 12:24:38 volumio volumio[1279]: at Pipe.onStreamRead (node:internal/stream_base_commons:190:23)
Jan 10 12:24:38 volumio volumio[1279]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 10 12:24:39 volumio sudo[2624]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-01-10 12:23'
Jan 10 12:24:39 volumio sudo[2624]: 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"