Dec 16 22:32:17 volumio volumio[5406]: info: Preload queue cleared
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::ClearQueue
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::stop
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::stPlaybackTimer
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::updateTrackBlock
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrackBlock
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 11
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::serviceStop
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 11
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::serviceStop
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::stop
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand stop
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::clearPlayQueue
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::saveQueue
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushQueue
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::addQueueItems
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::addQueueItems
Dec 16 22:32:17 volumio volumio[5406]: info: Preload queue cleared
Dec 16 22:32:17 volumio volumio[5406]: info: Adding Item to queue: albums://Dead%20Can%20Dance/Wake
Dec 16 22:32:17 volumio volumio[5406]: info: Exploding uri albums://Dead%20Can%20Dance/Wake in service mpd
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushQueue
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::saveQueue
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::updateTrackBlock
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrackBlock
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPlay
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::play index 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::stop
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::play index undefined
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::startPlaybackTimer
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::clearAddPlayTracks NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand stop
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand stop took 28 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand stop took 1 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand clear
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces system playlist update
Dec 16 22:32:17 volumio volumio[5406]: info: Ignoring MPD Status Update
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 7 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand clear took 7 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 6 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 6 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand add "NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3"
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService stop
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus stop
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: No code
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService stop
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus stop
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: No code
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 21ms
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 21ms
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces system playlist update
Dec 16 22:32:17 volumio volumio[5406]: info: Ignoring MPD Status Update
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces system playlist update
Dec 16 22:32:17 volumio volumio[5406]: info: Ignoring MPD Status Update
Dec 16 22:32:17 volumio volumio[5406]: error: updateQueue error: null
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces system playlist update
Dec 16 22:32:17 volumio volumio[5406]: info: Ignoring MPD Status Update
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 20ms
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand playlistinfo took 19 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand add "NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3" took 20 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 4ms
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 4ms
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseTrackInfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand play
Dec 16 22:32:17 volumio volumio[5406]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 30ms
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces system playlist update
Dec 16 22:32:17 volumio volumio[5406]: info: Ignoring MPD Status Update
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces system playlist update
Dec 16 22:32:17 volumio volumio[5406]: info: Ignoring MPD Status Update
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 12ms
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand play took 10 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 10ms
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 9ms
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 2 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info:
Dec 16 22:32:17 volumio volumio[5406]: ---------------------------- MPD announces state update: player
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::getState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand status
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 25 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 24 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 24 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand playlistinfo took 24 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 5 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand status took 4 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseTrackInfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseState
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Frontier (Demo)","artist":"Dead Can Dance","album":"Wake","uri":"NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3","trackType":"mp3"}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService play
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus stop
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 32ms
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseTrackInfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseTrackInfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseTrackInfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseTrackInfo
Dec 16 22:32:17 volumio volumio[5406]: verbose: ControllerMpd::parseTrackInfo
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Frontier (Demo)","artist":"Dead Can Dance","album":"Wake","uri":"NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3","trackType":"mp3"}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService play
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus play
Dec 16 22:32:17 volumio volumio[5406]: info: Received an update from plugin. extracting info from payload
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Frontier (Demo)","artist":"Dead Can Dance","album":"Wake","uri":"NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3","trackType":"mp3"}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService play
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus play
Dec 16 22:32:17 volumio volumio[5406]: info: Received an update from plugin. extracting info from payload
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Frontier (Demo)","artist":"Dead Can Dance","album":"Wake","uri":"NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3","trackType":"mp3"}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService play
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus play
Dec 16 22:32:17 volumio volumio[5406]: info: Received an update from plugin. extracting info from payload
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Frontier (Demo)","artist":"Dead Can Dance","album":"Wake","uri":"NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3","trackType":"mp3"}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService play
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus play
Dec 16 22:32:17 volumio volumio[5406]: info: Received an update from plugin. extracting info from payload
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: ControllerMpd::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::servicePushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: verbose: STATE SERVICE {"status":"play","position":0,"seek":871,"duration":181,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"Frontier (Demo)","artist":"Dead Can Dance","album":"Wake","uri":"NAS/data/media/music/artists/D/Dead Can Dance/Wake/Dead Can Dance - Frontier Demo.mp3","trackType":"mp3"}
Dec 16 22:32:17 volumio volumio[5406]: verbose: CURRENT POSITION 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState stateService play
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::syncState currentStatus play
Dec 16 22:32:17 volumio volumio[5406]: info: Received an update from plugin. extracting info from payload
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: CoreStateMachine::pushState
Dec 16 22:32:17 volumio volumio[5406]: info: CorePlayQueue::getTrack 0
Dec 16 22:32:17 volumio volumio[5406]: info: CoreCommandRouter::volumioPushState
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 62ms
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 62ms
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 62ms
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 44ms
Dec 16 22:32:17 volumio volumio[5406]: info: ------------------------------ 43ms
Dec 16 22:32:48 volumio volumio[5406]: info: Preload queue cleared
Dec 16 22:33:00 volumio volumio[5406]: info: CoreCommandRouter::executeOnPlugin: last_100 , handleBrowseUri
Dec 16 22:33:00 volumio volumio[5406]: info: Preload queue cleared
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/media/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Eleanor Rigby.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/media/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Taxman.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Got To Get You Into My Life.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - I Want To Tell You.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - For No One.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: https://stream.radioparadise.com/flacm
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/media/music/artists/K/Kruder & Dorfmeister/Kruder & Dorfmeister - Bomberclaad Joint.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/media/music/artists/K/Kruder & Dorfmeister/Kruder & Dorfmeister - The Lick.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/media/music/artists/K/Kruder & Dorfmeister/Kruder & Dorfmeister - Useless (Depeche Mode).mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/media/music/artists/K/Kruder & Dorfmeister/Kruder & Dorfmeister - Transfatty Acid.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Preloading song: mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/A/Aerosmith/Aerosmith & Run Dmc - Walk This Way.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Exploding uri mnt/NAS/data/media/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Eleanor Rigby.mp3 in service mpd
Dec 16 22:33:00 volumio volumio[5406]: info: Exploding uri mnt/NAS/data/media/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Taxman.mp3 in service mpd
Dec 16 22:33:00 volumio volumio[5406]: info: ALBUMART /albumart?cacheid=792&web=The%20Beatles/Revolver/extralarge&path=%2Fmnt%2FNAS%2Fdata%2Fmedia%2Fmusic%2Fartists%2FB%2FThe%20Beatles%2F1966%20-%20Revolver%2FThe%20Beatles%20-%20Eleanor%20Rigby.mp3&metadata=false
Dec 16 22:33:00 volumio volumio[5406]: info: URI /mnt/NAS/data/media/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Eleanor Rigby.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: ALBUMART /albumart?cacheid=792&web=The%20Beatles/Revolver/extralarge&path=%2Fmnt%2FNAS%2Fdata%2Fmedia%2Fmusic%2Fartists%2FB%2FThe%20Beatles%2F1966%20-%20Revolver%2FThe%20Beatles%20-%20Taxman.mp3&metadata=false
Dec 16 22:33:00 volumio volumio[5406]: info: URI /mnt/NAS/data/media/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Taxman.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: Exploding uri mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Got To Get You Into My Life.mp3 in service mpd
Dec 16 22:33:00 volumio volumio[5406]: info: Exploding uri mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - I Want To Tell You.mp3 in service mpd
Dec 16 22:33:00 volumio volumio[5406]: info: ALBUMART /albumart?cacheid=792&web=The%20Beatles/Revolver/extralarge&path=%2Fmnt%2FNAS%2Fdata%2Fbackup%2FFRQNB125099%2F2024-06-06%2FC%2Fusers%2Fkhirschm%2Fwork%2Ftmp%2Fmusic%2Fartists%2FB%2FThe%20Beatles%2F1966%20-%20Revolver%2FThe%20Beatles%20-%20Got%20To%20Get%20You%20Into%20My%20Life.mp3&metadata=false
Dec 16 22:33:00 volumio volumio[5406]: info: URI /mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - Got To Get You Into My Life.mp3
Dec 16 22:33:00 volumio volumio[5406]: info: ALBUMART /albumart?cacheid=792&web=The%20Beatles/Revolver/extralarge&path=%2Fmnt%2FNAS%2Fdata%2Fbackup%2FFRQNB125099%2F2024-06-06%2FC%2Fusers%2Fkhirschm%2Fwork%2Ftmp%2Fmusic%2Fartists%2FB%2FThe%20Beatles%2F1966%20-%20Revolver%2FThe%20Beatles%20-%20I%20Want%20To%20Tell%20You.mp3&metadata=false
Dec 16 22:33:00 volumio volumio[5406]: info: URI /mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - I Want To Tell You.mp3
Dec 16 22:33:01 volumio volumio[5406]: info: Exploding uri mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - For No One.mp3 in service mpd
Dec 16 22:33:01 volumio volumio[5406]: info: ALBUMART /albumart?cacheid=792&web=The%20Beatles/Revolver/extralarge&path=%2Fmnt%2FNAS%2Fdata%2Fbackup%2FFRQNB125099%2F2024-06-06%2FC%2Fusers%2Fkhirschm%2Fwork%2Ftmp%2Fmusic%2Fartists%2FB%2FThe%20Beatles%2F1966%20-%20Revolver%2FThe%20Beatles%20-%20For%20No%20One.mp3&metadata=false
Dec 16 22:33:01 volumio volumio[5406]: info: URI /mnt/NAS/data/backup/FRQNB125099/2024-06-06/C/users/khirschm/work/tmp/music/artists/B/The Beatles/1966 - Revolver/The Beatles - For No One.mp3
Dec 16 22:33:01 volumio volumio[5406]: info: Exploding uri https://stream.radioparadise.com/flacm in service radio_paradise
Dec 16 22:33:01 volumio volumio[5406]: error: [RadioParadise] explodeUri: No station found for uri "https://stream.radioparadise.com/flacm"
Dec 16 22:33:01 volumio volumio[5406]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 22:33:01 volumio volumio[5406]: TypeError: Cannot read properties of undefined (reading 'then')
Dec 16 22:33:01 volumio volumio[5406]: at CoreCommandRouter.explodeUriFromService (/volumio/app/index.js:1384:31)
Dec 16 22:33:01 volumio volumio[5406]: at CorePlayQueue.explodeUriFromCache (/volumio/app/playqueue.js:123:24)
Dec 16 22:33:01 volumio volumio[5406]: at CorePlayQueue.explodeUri (/volumio/app/playqueue.js:181:19)
Dec 16 22:33:01 volumio volumio[5406]: at Timeout._onTimeout (/volumio/app/playqueue.js:146:100)
Dec 16 22:33:01 volumio volumio[5406]: at listOnTimeout (node:internal/timers:573:17)
Dec 16 22:33:01 volumio volumio[5406]: at process.processTimers (node:internal/timers:514:7)
Dec 16 22:33:01 volumio volumio[5406]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 16 22:33:01 volumio sudo[18309]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-16 22:32'
Dec 16 22:33:01 volumio sudo[18309]: 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"