Dec 12 12:06:01 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 687.
Dec 12 12:06:01 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:01 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:01 volumio upmpdcli[30128]: Could not open config: /tmp/upmpdcli.conf
Dec 12 12:06:01 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 12 12:06:01 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 12 12:06:04 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:04 volumio volumio[1098]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::ClearQueue
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:04 volumio volumio[1098]: info: CorePlayQueue::clearPlayQueue
Dec 12 12:06:04 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:04 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::addQueueItems
Dec 12 12:06:04 volumio volumio[1098]: info: CorePlayQueue::addQueueItems
Dec 12 12:06:04 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:04 volumio volumio[1098]: info: Adding Item to queue: http://live-aacplus-64.kexp.org/kexp64.aac
Dec 12 12:06:04 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Dec 12 12:06:04 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:04 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:04 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:04 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::play index 0
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::play index undefined
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:04 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer
Dec 12 12:06:04 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:04 volumio volumio[1098]: info: [1765512364182] ControllerWebradio::clearAddPlayTrack
Dec 12 12:06:04 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:04 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:04 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:04 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3"
Dec 12 12:06:04 volumio volumio[1098]: info: ------------------------------ 9534ms
Dec 12 12:06:04 volumio volumio[1098]: info: ------------------------------ 9534ms
Dec 12 12:06:04 volumio volumio[1098]: info: sendMpdCommand stop took 257 milliseconds
Dec 12 12:06:04 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear
Dec 12 12:06:04 volumio volumio[1098]: info:
Dec 12 12:06:04 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:04 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:04 volumio volumio[1098]: info:
Dec 12 12:06:04 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:04 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:04 volumio volumio[1098]: info: sendMpdCommand add "https://absolut-ai.live-sm.absolutradio.de/absolut-ai/stream/mp3" took 1 milliseconds
Dec 12 12:06:04 volumio volumio[1098]: info: sendMpdCommand clear took 0 milliseconds
Dec 12 12:06:04 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 12 12:06:04 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play
Dec 12 12:06:04 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand load "http://live-aacplus-64.kexp.org/kexp64.aac"
Dec 12 12:06:04 volumio volumio[1098]: info:
Dec 12 12:06:04 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:04 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:04 volumio volumio[1098]: info:
Dec 12 12:06:04 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:04 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:04 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:04 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:04 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:04 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:04 volumio volumio[1098]: info: sendMpdCommand play took 1 milliseconds
Dec 12 12:06:08 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:08 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:08 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand add "http://live-aacplus-64.kexp.org/kexp64.aac"
Dec 12 12:06:08 volumio volumio[1098]: info: ------------------------------ 3861ms
Dec 12 12:06:08 volumio volumio[1098]: info: ------------------------------ 3861ms
Dec 12 12:06:08 volumio volumio[1098]: info:
Dec 12 12:06:08 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:08 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:08 volumio volumio[1098]: info:
Dec 12 12:06:08 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:08 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:08 volumio volumio[1098]: info:
Dec 12 12:06:08 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:08 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:08 volumio volumio[1098]: info: sendMpdCommand add "http://live-aacplus-64.kexp.org/kexp64.aac" took 0 milliseconds
Dec 12 12:06:08 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:08 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:08 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 12 12:06:08 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play
Dec 12 12:06:08 volumio volumio[1098]: info:
Dec 12 12:06:08 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:08 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:08 volumio volumio[1098]: info:
Dec 12 12:06:08 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:08 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:08 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:08 volumio volumio[1098]: info: sendMpdCommand play took 1 milliseconds
Dec 12 12:06:08 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:08 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand status took 18 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand status took 18 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:10 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand status took 23 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand status took 5 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand status took 4 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"kexp64.aac","artist":"KEXP 90.3 FM","album":null,"uri":"http://live-aacplus-64.kexp.org/kexp64.aac","trackType":"aac"}
Dec 12 12:06:10 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"kexp64.aac","artist":"KEXP 90.3 FM","album":null,"uri":"http://live-aacplus-64.kexp.org/kexp64.aac","trackType":"aac"}
Dec 12 12:06:10 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:10 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 26ms
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 31ms
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:10 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:10 volumio volumio[1098]: info:
Dec 12 12:06:10 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:10 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 9 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 9 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 9 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 9 milliseconds
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:10 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":502,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"kexp64.aac","artist":"KEXP 90.3 FM","album":null,"uri":"http://live-aacplus-64.kexp.org/kexp64.aac","trackType":"aac"}
Dec 12 12:06:10 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:10 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1004,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"kexp64.aac","artist":"KEXP 90.3 FM","album":null,"uri":"http://live-aacplus-64.kexp.org/kexp64.aac","trackType":"aac"}
Dec 12 12:06:10 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:10 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1004,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"kexp64.aac","artist":"KEXP 90.3 FM","album":null,"uri":"http://live-aacplus-64.kexp.org/kexp64.aac","trackType":"aac"}
Dec 12 12:06:10 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:10 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1004,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"63 Kbps","isStreaming":false,"title":"kexp64.aac","artist":"KEXP 90.3 FM","album":null,"uri":"http://live-aacplus-64.kexp.org/kexp64.aac","trackType":"aac"}
Dec 12 12:06:10 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:10 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:10 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 46ms
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 28ms
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 27ms
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 27ms
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 19ms
Dec 12 12:06:10 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:12 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::ClearQueue
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::stPlaybackTimer
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::serviceStop
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::serviceStop
Dec 12 12:06:12 volumio volumio[1098]: info: [1765512372548] ControllerWebradio::stop
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::clearPlayQueue
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::addQueueItems
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::addQueueItems
Dec 12 12:06:12 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:12 volumio volumio[1098]: info: Adding Item to queue: https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::play index 0
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::play index undefined
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: [1765512372550] ControllerWebradio::clearAddPlayTrack
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:12 volumio volumio[1098]: info:
Dec 12 12:06:12 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:12 volumio volumio[1098]: info: sendMpdCommand stop took 3 milliseconds
Dec 12 12:06:12 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:12 volumio volumio[1098]: info: sendMpdCommand stop took 1 milliseconds
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear
Dec 12 12:06:12 volumio volumio[1098]: info:
Dec 12 12:06:12 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:12 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:12 volumio volumio[1098]: info:
Dec 12 12:06:12 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:12 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:12 volumio volumio[1098]: info:
Dec 12 12:06:12 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:12 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:12 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:12 volumio volumio[1098]: info: sendMpdCommand clear took 0 milliseconds
Dec 12 12:06:12 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:12 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand load "https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream"
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:12 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:12 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:12 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:12 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:12 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:12 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 12 12:06:12 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 12 12:06:12 volumio volumio[1098]: info:
Dec 12 12:06:12 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:12 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:12 volumio volumio[1098]: info:
Dec 12 12:06:12 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:12 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:12 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:12 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 12 12:06:12 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 12 12:06:12 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:12 volumio volumio[1098]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Dec 12 12:06:12 volumio volumio[1098]: info: ------------------------------ 4ms
Dec 12 12:06:14 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:14 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:14 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand add "https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream"
Dec 12 12:06:14 volumio volumio[1098]: info: ------------------------------ 2320ms
Dec 12 12:06:14 volumio volumio[1098]: info: ------------------------------ 2320ms
Dec 12 12:06:14 volumio volumio[1098]: info:
Dec 12 12:06:14 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:14 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:14 volumio volumio[1098]: info: sendMpdCommand add "https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream" took 0 milliseconds
Dec 12 12:06:14 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 12 12:06:14 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play
Dec 12 12:06:14 volumio volumio[1098]: info:
Dec 12 12:06:14 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:14 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:14 volumio volumio[1098]: info:
Dec 12 12:06:14 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:14 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:14 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:14 volumio volumio[1098]: info: sendMpdCommand play took 1 milliseconds
Dec 12 12:06:14 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:14 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 11ms
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 17ms
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 8 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 8 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 11ms
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 5 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 17ms
Dec 12 12:06:16 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 688.
Dec 12 12:06:16 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:16 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:16 volumio upmpdcli[30178]: Could not open config: /tmp/upmpdcli.conf
Dec 12 12:06:16 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 12 12:06:16 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:16 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:16 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:16 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:16 volumio volumio[1098]: info:
Dec 12 12:06:16 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 2ms
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ABC - Tears Are Not Enough","artist":"Beaumont Stream","album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ABC - Tears Are Not Enough","artist":"Beaumont Stream","album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 7ms
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 7ms
Dec 12 12:06:16 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 12 12:06:16 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:16 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:16 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:16 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":91,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"ABC - Tears Are Not Enough","artist":"Beaumont Stream","album":null,"uri":"https://stream13.shoutcastsolutions.com/proxy/gbeaum00?mp=/stream","trackType":""}
Dec 12 12:06:16 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:16 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:16 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:16 volumio volumio[1098]: info: ------------------------------ 10ms
Dec 12 12:06:31 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 689.
Dec 12 12:06:31 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:31 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:31 volumio upmpdcli[30209]: Could not open config: /tmp/upmpdcli.conf
Dec 12 12:06:31 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 12 12:06:31 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 12 12:06:32 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::ClearQueue
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::stPlaybackTimer
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::serviceStop
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::serviceStop
Dec 12 12:06:32 volumio volumio[1098]: info: [1765512392138] ControllerWebradio::stop
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::clearPlayQueue
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::addQueueItems
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::addQueueItems
Dec 12 12:06:32 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:32 volumio volumio[1098]: info: Adding Item to queue: http://mscp3.live-streams.nl:8250/class-flac.flac
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::play index 0
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::play index undefined
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: [1765512392140] ControllerWebradio::clearAddPlayTrack
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:32 volumio volumio[1098]: info:
Dec 12 12:06:32 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:32 volumio volumio[1098]: info: sendMpdCommand stop took 4 milliseconds
Dec 12 12:06:32 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:32 volumio volumio[1098]: info: sendMpdCommand stop took 2 milliseconds
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear
Dec 12 12:06:32 volumio volumio[1098]: info:
Dec 12 12:06:32 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:32 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:32 volumio volumio[1098]: info:
Dec 12 12:06:32 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:32 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:32 volumio volumio[1098]: info:
Dec 12 12:06:32 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:32 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:32 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:32 volumio volumio[1098]: info: sendMpdCommand clear took 1 milliseconds
Dec 12 12:06:32 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:32 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8250/class-flac.flac"
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:32 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:32 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:32 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:32 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:32 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:32 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:32 volumio volumio[1098]: info: ------------------------------ 4ms
Dec 12 12:06:32 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 12 12:06:32 volumio volumio[1098]: info:
Dec 12 12:06:32 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:32 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:32 volumio volumio[1098]: info:
Dec 12 12:06:32 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:32 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:32 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:32 volumio volumio[1098]: info: ------------------------------ 4ms
Dec 12 12:06:34 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1860 milliseconds
Dec 12 12:06:34 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8250/class-flac.flac"
Dec 12 12:06:34 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:34 volumio volumio[1098]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Dec 12 12:06:34 volumio volumio[1098]: info: ------------------------------ 1861ms
Dec 12 12:06:34 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:34 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:34 volumio volumio[1098]: info:
Dec 12 12:06:34 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:34 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:34 volumio volumio[1098]: info: ------------------------------ 1858ms
Dec 12 12:06:34 volumio volumio[1098]: info: ------------------------------ 1858ms
Dec 12 12:06:34 volumio volumio[1098]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8250/class-flac.flac" took 1 milliseconds
Dec 12 12:06:34 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 12 12:06:34 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play
Dec 12 12:06:34 volumio volumio[1098]: info:
Dec 12 12:06:34 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:34 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:34 volumio volumio[1098]: info:
Dec 12 12:06:34 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:34 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:34 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:34 volumio volumio[1098]: info: sendMpdCommand play took 0 milliseconds
Dec 12 12:06:34 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:34 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 10 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 10 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 10 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 14ms
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 17ms
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 17ms
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 14ms
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 13ms
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 13ms
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:35 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:35 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:35 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:35 volumio volumio[1098]: info:
Dec 12 12:06:35 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 14ms
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 14 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 14ms
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 14 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 14ms
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand status took 14 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"class-flac.flac","artist":"Naim Classical","album":null,"uri":"http://mscp3.live-streams.nl:8250/class-flac.flac","trackType":"flac"}
Dec 12 12:06:35 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:35 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:35 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 21ms
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 21ms
Dec 12 12:06:35 volumio volumio[1098]: info: ------------------------------ 21ms
Dec 12 12:06:42 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::ClearQueue
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::stPlaybackTimer
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::serviceStop
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::serviceStop
Dec 12 12:06:42 volumio volumio[1098]: info: [1765512402789] ControllerWebradio::stop
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::clearPlayQueue
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::addQueueItems
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::addQueueItems
Dec 12 12:06:42 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:42 volumio volumio[1098]: info: Adding Item to queue: http://mscp3.live-streams.nl:8340/jazz-flac.flac
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::play index 0
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::play index undefined
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: [1765512402792] ControllerWebradio::clearAddPlayTrack
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:42 volumio volumio[1098]: info:
Dec 12 12:06:42 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:42 volumio volumio[1098]: info: sendMpdCommand stop took 4 milliseconds
Dec 12 12:06:42 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:42 volumio volumio[1098]: info: sendMpdCommand stop took 1 milliseconds
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear
Dec 12 12:06:42 volumio volumio[1098]: info:
Dec 12 12:06:42 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:42 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:42 volumio volumio[1098]: info:
Dec 12 12:06:42 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:42 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:42 volumio volumio[1098]: info:
Dec 12 12:06:42 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:42 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:42 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:42 volumio volumio[1098]: info: sendMpdCommand clear took 1 milliseconds
Dec 12 12:06:42 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8340/jazz-flac.flac"
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:42 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:42 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 12 12:06:42 volumio volumio[1098]: info:
Dec 12 12:06:42 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:42 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:42 volumio volumio[1098]: info:
Dec 12 12:06:42 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:42 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:42 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:42 volumio volumio[1098]: info: sendMpdCommand status took 3 milliseconds
Dec 12 12:06:42 volumio volumio[1098]: info: ------------------------------ 2ms
Dec 12 12:06:42 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:42 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:42 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:42 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:42 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:42 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:42 volumio volumio[1098]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Dec 12 12:06:42 volumio volumio[1098]: info: ------------------------------ 5ms
Dec 12 12:06:42 volumio volumio[1098]: info: ------------------------------ 5ms
Dec 12 12:06:43 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8340/jazz-flac.flac"
Dec 12 12:06:43 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:43 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:43 volumio volumio[1098]: info: ------------------------------ 1030ms
Dec 12 12:06:43 volumio volumio[1098]: info: ------------------------------ 1030ms
Dec 12 12:06:43 volumio volumio[1098]: info:
Dec 12 12:06:43 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:43 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:43 volumio volumio[1098]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8340/jazz-flac.flac" took 0 milliseconds
Dec 12 12:06:43 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 12 12:06:43 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play
Dec 12 12:06:43 volumio volumio[1098]: info:
Dec 12 12:06:43 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:43 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:43 volumio volumio[1098]: info:
Dec 12 12:06:43 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:43 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:43 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:43 volumio volumio[1098]: info: sendMpdCommand play took 0 milliseconds
Dec 12 12:06:43 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:43 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:44 volumio volumio[1098]: info:
Dec 12 12:06:44 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:44 volumio volumio[1098]: info:
Dec 12 12:06:44 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:44 volumio volumio[1098]: info:
Dec 12 12:06:44 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand status took 11 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:44 volumio volumio[1098]: info:
Dec 12 12:06:44 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:44 volumio volumio[1098]: info:
Dec 12 12:06:44 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand status took 11 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand status took 11 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:44 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop
Dec 12 12:06:44 volumio volumio[1098]: info: ------------------------------ 11ms
Dec 12 12:06:44 volumio volumio[1098]: info:
Dec 12 12:06:44 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 0 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:44 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:44 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:44 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:44 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:44 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:44 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:44 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:44 volumio volumio[1098]: info: ------------------------------ 7ms
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 6 milliseconds
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:44 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:44 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:44 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:44 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:44 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:44 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:44 volumio volumio[1098]: info: ------------------------------ 11ms
Dec 12 12:06:44 volumio volumio[1098]: info: ------------------------------ 11ms
Dec 12 12:06:45 volumio volumio[1098]: info:
Dec 12 12:06:45 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:45 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:45 volumio volumio[1098]: info:
Dec 12 12:06:45 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:45 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:45 volumio volumio[1098]: info:
Dec 12 12:06:45 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:45 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:45 volumio volumio[1098]: info:
Dec 12 12:06:45 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:45 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:45 volumio volumio[1098]: info:
Dec 12 12:06:45 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:45 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:45 volumio volumio[1098]: info:
Dec 12 12:06:45 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:45 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:45 volumio volumio[1098]: info: ------------------------------ 10ms
Dec 12 12:06:45 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:45 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:06:45 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:45 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:06:45 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:45 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:45 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:45 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:45 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:45 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:45 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:45 volumio volumio[1098]: info: ------------------------------ 12ms
Dec 12 12:06:45 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 12 12:06:45 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:45 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:45 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:45 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:45 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:45 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:45 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:45 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:45 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:45 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":980,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"jazz-flac.flac","artist":"Naim Jazz","album":null,"uri":"http://mscp3.live-streams.nl:8340/jazz-flac.flac","trackType":"flac"}
Dec 12 12:06:45 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:45 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:45 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:45 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:45 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:46 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 690.
Dec 12 12:06:46 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:46 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:06:47 volumio upmpdcli[30261]: Could not open config: /tmp/upmpdcli.conf
Dec 12 12:06:47 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 12 12:06:47 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 12 12:06:52 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::volumioReplaceandPlayItems
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::ClearQueue
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::stPlaybackTimer
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::serviceStop
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::serviceStop
Dec 12 12:06:52 volumio volumio[1098]: info: [1765512412258] ControllerWebradio::stop
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::clearPlayQueue
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::addQueueItems
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::addQueueItems
Dec 12 12:06:52 volumio volumio[1098]: info: Preload queue cleared
Dec 12 12:06:52 volumio volumio[1098]: info: Adding Item to queue: http://mscp3.live-streams.nl:8360/flac.flac
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::volumioPushQueue
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::saveQueue
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::updateTrackBlock
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrackBlock
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::volumioPlay
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::play index 0
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::stop
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::play index undefined
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService undefined
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::startPlaybackTimer
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: [1765512412260] ControllerWebradio::clearAddPlayTrack
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand stop
Dec 12 12:06:52 volumio volumio[1098]: info:
Dec 12 12:06:52 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:52 volumio volumio[1098]: info: sendMpdCommand stop took 9 milliseconds
Dec 12 12:06:52 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:52 volumio volumio[1098]: info: sendMpdCommand stop took 7 milliseconds
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand clear
Dec 12 12:06:52 volumio volumio[1098]: info:
Dec 12 12:06:52 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:52 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:52 volumio volumio[1098]: info:
Dec 12 12:06:52 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:52 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:52 volumio volumio[1098]: info:
Dec 12 12:06:52 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:52 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:52 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:52 volumio volumio[1098]: info: sendMpdCommand clear took 0 milliseconds
Dec 12 12:06:52 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:52 volumio volumio[1098]: info: sendMpdCommand status took 0 milliseconds
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand load "http://mscp3.live-streams.nl:8360/flac.flac"
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:52 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:52 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:52 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:52 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:52 volumio volumio[1098]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Dec 12 12:06:52 volumio volumio[1098]: info: ------------------------------ 2ms
Dec 12 12:06:52 volumio volumio[1098]: info: ------------------------------ 2ms
Dec 12 12:06:52 volumio volumio[1098]: info:
Dec 12 12:06:52 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:52 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:52 volumio volumio[1098]: info:
Dec 12 12:06:52 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:52 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:52 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:52 volumio volumio[1098]: info: ------------------------------ 2ms
Dec 12 12:06:52 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 2 milliseconds
Dec 12 12:06:52 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:52 volumio volumio[1098]: error: ControllerMpd::pushError: TypeError: Cannot read properties of undefined (reading 'split')
Dec 12 12:06:52 volumio volumio[1098]: info: ------------------------------ 4ms
Dec 12 12:06:53 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:53 volumio volumio[1098]: error: updateQueue error: null
Dec 12 12:06:53 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac"
Dec 12 12:06:53 volumio volumio[1098]: info: ------------------------------ 1071ms
Dec 12 12:06:53 volumio volumio[1098]: info: ------------------------------ 1071ms
Dec 12 12:06:53 volumio volumio[1098]: info:
Dec 12 12:06:53 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:53 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:53 volumio volumio[1098]: info: sendMpdCommand add "http://mscp3.live-streams.nl:8360/flac.flac" took 1 milliseconds
Dec 12 12:06:53 volumio volumio[1098]: info: CoreStateMachine::setConsumeUpdateService mpd
Dec 12 12:06:53 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand play
Dec 12 12:06:53 volumio volumio[1098]: info: ------------------------------ 1ms
Dec 12 12:06:53 volumio volumio[1098]: info:
Dec 12 12:06:53 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:53 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:53 volumio volumio[1098]: info:
Dec 12 12:06:53 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:53 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:53 volumio volumio[1098]: info: sendMpdCommand play took 0 milliseconds
Dec 12 12:06:53 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:53 volumio volumio[1098]: info: ------------------------------ 0ms
Dec 12 12:06:54 volumio volumio[1098]: info:
Dec 12 12:06:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:54 volumio volumio[1098]: info:
Dec 12 12:06:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:54 volumio volumio[1098]: info:
Dec 12 12:06:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:54 volumio volumio[1098]: info:
Dec 12 12:06:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:54 volumio volumio[1098]: info:
Dec 12 12:06:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand status took 10 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand status took 10 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:54 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus stop
Dec 12 12:06:54 volumio volumio[1098]: info: ------------------------------ 10ms
Dec 12 12:06:54 volumio volumio[1098]: info:
Dec 12 12:06:54 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand status took 1 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 1 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:54 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:54 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:54 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:54 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:54 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:54 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:54 volumio volumio[1098]: info: ------------------------------ 18ms
Dec 12 12:06:54 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand status took 9 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 8 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:54 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:54 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: ------------------------------ 11ms
Dec 12 12:06:54 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 4 milliseconds
Dec 12 12:06:54 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:54 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":null,"album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:54 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:54 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:54 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:54 volumio volumio[1098]: info: ------------------------------ 14ms
Dec 12 12:06:55 volumio volumio[1098]: info:
Dec 12 12:06:55 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:55 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:55 volumio volumio[1098]: info:
Dec 12 12:06:55 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:55 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:55 volumio volumio[1098]: info:
Dec 12 12:06:55 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:55 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:55 volumio volumio[1098]: info:
Dec 12 12:06:55 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:55 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:55 volumio volumio[1098]: info:
Dec 12 12:06:55 volumio volumio[1098]: ---------------------------- MPD announces system playlist update
Dec 12 12:06:55 volumio volumio[1098]: info: Ignoring MPD Status Update
Dec 12 12:06:55 volumio volumio[1098]: info:
Dec 12 12:06:55 volumio volumio[1098]: ---------------------------- MPD announces state update: player
Dec 12 12:06:55 volumio volumio[1098]: info: ControllerMpd::getState
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand status
Dec 12 12:06:55 volumio volumio[1098]: info: ------------------------------ 2ms
Dec 12 12:06:55 volumio volumio[1098]: info: sendMpdCommand status took 3 milliseconds
Dec 12 12:06:55 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 12 12:06:55 volumio volumio[1098]: info: sendMpdCommand status took 3 milliseconds
Dec 12 12:06:55 volumio volumio[1098]: info: ------------------------------ 3ms
Dec 12 12:06:55 volumio volumio[1098]: info: sendMpdCommand status took 3 milliseconds
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::parseState
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Dec 12 12:06:55 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 12 12:06:55 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 12 12:06:55 volumio volumio[1098]: info: sendMpdCommand playlistinfo took 3 milliseconds
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:55 volumio volumio[1098]: verbose: ControllerMpd::parseTrackInfo
Dec 12 12:06:55 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:55 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:55 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":501,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:55 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:55 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:55 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:55 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:55 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":501,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:55 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:55 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:55 volumio volumio[1098]: info: ControllerMpd::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::servicePushState
Dec 12 12:06:55 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:55 volumio volumio[1098]: verbose: STATE SERVICE {"status":"play","position":0,"seek":501,"duration":0,"samplerate":"44.1 kHz","bitdepth":"16 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"flac.flac","artist":"Naim Radio","album":null,"uri":"http://mscp3.live-streams.nl:8360/flac.flac","trackType":"flac"}
Dec 12 12:06:55 volumio volumio[1098]: verbose: CURRENT POSITION 0
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::syncState stateService play
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::syncState currentStatus play
Dec 12 12:06:55 volumio volumio[1098]: info: Received an update from plugin. extracting info from payload
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CorePlayQueue::getTrack 0
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreStateMachine::pushState
Dec 12 12:06:55 volumio volumio[1098]: info: CoreCommandRouter::volumioPushState
Dec 12 12:06:55 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:06:55 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:06:55 volumio volumio[1098]: info: ------------------------------ 9ms
Dec 12 12:07:02 volumio systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 691.
Dec 12 12:07:02 volumio systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:07:02 volumio systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD.
Dec 12 12:07:02 volumio upmpdcli[30295]: Could not open config: /tmp/upmpdcli.conf
Dec 12 12:07:02 volumio systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE
Dec 12 12:07:02 volumio systemd[1]: upmpdcli.service: Failed with result 'exit-code'.
Dec 12 12:07:05 volumio volumio[1098]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 12 12:07:05 volumio volumio[1098]: Error: connect ETIMEDOUT 173.234.53.168:443
Dec 12 12:07:05 volumio volumio[1098]: at TCPConnectWrap.afterConnect [as oncomplete] (node:net:1595:16) {
Dec 12 12:07:05 volumio volumio[1098]: errno: -110,
Dec 12 12:07:05 volumio volumio[1098]: code: 'ETIMEDOUT',
Dec 12 12:07:05 volumio volumio[1098]: syscall: 'connect',
Dec 12 12:07:05 volumio volumio[1098]: address: '173.234.53.168',
Dec 12 12:07:05 volumio volumio[1098]: port: 443
Dec 12 12:07:05 volumio volumio[1098]: }
Dec 12 12:07:05 volumio volumio[1098]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 12 12:07:05 volumio sudo[30328]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-12 12:06'
Dec 12 12:07:05 volumio sudo[30328]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
PRETTY_NAME="Debian GNU/Linux 12 (bookworm)"
NAME="Debian GNU/Linux"
VERSION_ID="12"
VERSION="12 (bookworm)"
VERSION_CODENAME=bookworm
ID=debian
HOME_URL="https://www.debian.org/"
SUPPORT_URL="https://www.debian.org/support"
BUG_REPORT_URL="https://bugs.debian.org/"
VOLUMIO_BUILD_VERSION="0c6d448ea4b31d0a461414ea8d010627ba7a364e"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu Dec 11 09:48:33 UTC 2025"
VOLUMIO_VERSION="4.079"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="c3d95df7f923f408094722dd4c3ff2fe"