-- Logs begin at Thu 2019-02-14 12:11:59 EET, end at Mon 2024-04-15 19:02:40 EEST. --
Apr 15 19:01:13 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 15 19:01:13 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 15 19:01:13 volumio volumio[948]: info: Discovery: Getting this device information
Apr 15 19:01:13 volumio volumio[948]: info: CoreCommandRouter::volumioGetState
Apr 15 19:01:13 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::volumioNext
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::next
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::serviceStop
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::serviceStop
Apr 15 19:01:14 volumio volumio[948]: info: [1713196874572] ControllerWebradio::stop
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:14 volumio volumio[948]: info: sendMpdCommand stop took 39 milliseconds
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 1
Apr 15 19:01:14 volumio volumio[948]: info:
Apr 15 19:01:14 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:14 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:14 volumio volumio[948]: info:
Apr 15 19:01:14 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:14 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:14 volumio volumio[948]: info:
Apr 15 19:01:14 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:14 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:14 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:01:14 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:01:14 volumio volumio[948]: info: sendMpdCommand status took 3 milliseconds
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:14 volumio volumio[948]: info: sendMpdCommand playlistinfo took 3 milliseconds
Apr 15 19:01:14 volumio volumio[948]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 15 19:01:14 volumio volumio[948]: info: sendMpdCommand playlistinfo took 4 milliseconds
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:14 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:14 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:14 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:14 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:14 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:14 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:14 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:14 volumio volumio[948]: info: ------------------------------ 72ms
Apr 15 19:01:14 volumio volumio[948]: info: ------------------------------ 70ms
Apr 15 19:01:14 volumio volumio[948]: info: ------------------------------ 69ms
Apr 15 19:01:21 volumio volumio[948]: info: CoreCommandRouter::volumioNext
Apr 15 19:01:21 volumio volumio[948]: info: CoreStateMachine::next
Apr 15 19:01:21 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:21 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:21 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:01:21 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:21 volumio volumio[948]: info: CorePlayQueue::getTrack 1
Apr 15 19:01:26 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:26 volumio volumio[948]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::ClearQueue
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:26 volumio volumio[948]: info: CorePlayQueue::clearPlayQueue
Apr 15 19:01:26 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:26 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::addQueueItems
Apr 15 19:01:26 volumio volumio[948]: info: CorePlayQueue::addQueueItems
Apr 15 19:01:26 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:26 volumio volumio[948]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1669311
Apr 15 19:01:26 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 15 19:01:26 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:26 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:26 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:26 volumio volumio[948]: info: CoreCommandRouter::volumioPlay
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::play index 0
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:26 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:26 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer
Apr 15 19:01:26 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:26 volumio volumio[948]: info: [1713196886472] ControllerWebradio::clearAddPlayTrack
Apr 15 19:01:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:26 volumio volumio[948]: info: sendMpdCommand stop took 6 milliseconds
Apr 15 19:01:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear
Apr 15 19:01:26 volumio volumio[948]: info: sendMpdCommand clear took 1 milliseconds
Apr 15 19:01:26 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1669311"
Apr 15 19:01:26 volumio volumio[948]: info:
Apr 15 19:01:26 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:26 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:26 volumio volumio[948]: info:
Apr 15 19:01:26 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:26 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:26 volumio volumio[948]: info:
Apr 15 19:01:26 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:26 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:32 volumio volumio[948]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1669311" took 5945 milliseconds
Apr 15 19:01:32 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 15 19:01:32 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play
Apr 15 19:01:32 volumio volumio[948]: info:
Apr 15 19:01:32 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:32 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:32 volumio volumio[948]: info: ------------------------------ 5948ms
Apr 15 19:01:32 volumio volumio[948]: info: ------------------------------ 5948ms
Apr 15 19:01:32 volumio volumio[948]: info: ------------------------------ 5946ms
Apr 15 19:01:32 volumio volumio[948]: Upnp client error: Error: This socket has been ended by the other party
Apr 15 19:01:32 volumio volumio[948]: Upnp client error: Error: This socket has been ended by the other party
Apr 15 19:01:32 volumio volumio[948]: info:
Apr 15 19:01:32 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:32 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:32 volumio volumio[948]: info:
Apr 15 19:01:32 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:32 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:32 volumio volumio[948]: info: sendMpdCommand play took 15 milliseconds
Apr 15 19:01:32 volumio volumio[948]: info: ------------------------------ 15ms
Apr 15 19:01:32 volumio volumio[948]: info: ------------------------------ 8ms
Apr 15 19:01:32 volumio volumio[948]: info: ------------------------------ 4ms
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 9 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 14 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: 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":null,"isStreaming":false,"title":"stream2","artist":"(#1 - 13/200) AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: 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":null,"isStreaming":false,"title":"stream2","artist":"(#1 - 13/200) AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: 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":null,"isStreaming":false,"title":"stream2","artist":"(#1 - 13/200) AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 81ms
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 154ms
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 152ms
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:33 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 131 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 129 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 129 milliseconds
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: 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":null,"isStreaming":false,"title":"Steve Roach - Slowly Revealed (MRG.fm edit)","artist":"AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: 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":null,"isStreaming":false,"title":"Steve Roach - Slowly Revealed (MRG.fm edit)","artist":"AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: 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":null,"isStreaming":false,"title":"Steve Roach - Slowly Revealed (MRG.fm edit)","artist":"AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 277ms
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 268ms
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 266ms
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:33 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:33 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:33 volumio volumio[948]: info:
Apr 15 19:01:33 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 193ms
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 191 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 66ms
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 64 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 63ms
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand status took 62 milliseconds
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 15 19:01:33 volumio volumio[948]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1108,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Steve Roach - Slowly Revealed (MRG.fm edit)","artist":"AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1233,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Steve Roach - Slowly Revealed (MRG.fm edit)","artist":"AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:33 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:33 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1233,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Steve Roach - Slowly Revealed (MRG.fm edit)","artist":"AmbientRadio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8888/stream2","trackType":""}
Apr 15 19:01:33 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:33 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:33 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 330ms
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 203ms
Apr 15 19:01:33 volumio volumio[948]: info: ------------------------------ 201ms
Apr 15 19:01:51 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::ClearQueue
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::serviceStop
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::serviceStop
Apr 15 19:01:51 volumio volumio[948]: info: [1713196911664] ControllerWebradio::stop
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::clearPlayQueue
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::addQueueItems
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::addQueueItems
Apr 15 19:01:51 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:51 volumio volumio[948]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99516710
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::volumioPlay
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::play index 0
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: [1713196911704] ControllerWebradio::clearAddPlayTrack
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand stop took 51 milliseconds
Apr 15 19:01:51 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand stop took 12 milliseconds
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:51 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:51 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:51 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand status took 9 milliseconds
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand clear took 8 milliseconds
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99516710"
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:51 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:51 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:51 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:51 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 51ms
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 50ms
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:51 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:51 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:51 volumio volumio[948]: error: updateQueue error: null
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 53ms
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand playlistinfo took 50 milliseconds
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:51 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 65ms
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99516710" took 161 milliseconds
Apr 15 19:01:51 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 15 19:01:51 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:51 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 122ms
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 120ms
Apr 15 19:01:51 volumio volumio[948]: info: sendMpdCommand play took 4 milliseconds
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:51 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:51 volumio volumio[948]: info:
Apr 15 19:01:51 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:51 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 10ms
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 6ms
Apr 15 19:01:51 volumio volumio[948]: info: ------------------------------ 5ms
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 13 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 12 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 11 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: 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":"(#1 - 11/1000) Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: 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":"(#1 - 11/1000) Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: 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":"(#1 - 11/1000) Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 62ms
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 109ms
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 109ms
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 88 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 86 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 85 milliseconds
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: 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":"(#1 - 11/1000) Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: 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":"(#1 - 11/1000) Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: 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":"(#1 - 11/1000) Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 227ms
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 219ms
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 218ms
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:52 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:52 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:52 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:52 volumio volumio[948]: info:
Apr 15 19:01:52 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 25ms
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 22 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 9ms
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 5ms
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 15 19:01:52 volumio volumio[948]: info: sendMpdCommand playlistinfo took 10 milliseconds
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ambiesphere - The Ascent","artist":"Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ambiesphere - The Ascent","artist":"Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:52 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:52 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Ambiesphere - The Ascent","artist":"Ambiesphere","album":null,"uri":"http://139.162.245.57:8347/stream","trackType":""}
Apr 15 19:01:52 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:52 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:52 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 155ms
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 139ms
Apr 15 19:01:52 volumio volumio[948]: info: ------------------------------ 138ms
Apr 15 19:01:56 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::ClearQueue
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::serviceStop
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::serviceStop
Apr 15 19:01:56 volumio volumio[948]: info: [1713196916124] ControllerWebradio::stop
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::clearPlayQueue
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::addQueueItems
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::addQueueItems
Apr 15 19:01:56 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:56 volumio volumio[948]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1624707
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPlay
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::play index 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: [1713196916158] ControllerWebradio::clearAddPlayTrack
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand stop took 44 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand stop took 11 milliseconds
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:56 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 17 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand clear took 16 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 9 milliseconds
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1624707"
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 51ms
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 50ms
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:56 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:56 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:56 volumio volumio[948]: error: updateQueue error: null
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 55ms
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand playlistinfo took 48 milliseconds
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:56 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 75ms
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1624707" took 172 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:56 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 138ms
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 136ms
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand play took 3 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:56 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:56 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 10ms
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 6ms
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 4ms
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info:
Apr 15 19:01:56 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 10 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: 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":"(#1 - 7/200) Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:56 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: 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":"(#1 - 7/200) Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:56 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:56 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: 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":"(#1 - 7/200) Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:56 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:56 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 50ms
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 93ms
Apr 15 19:01:56 volumio volumio[948]: info: ------------------------------ 92ms
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand playlistinfo took 79 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand playlistinfo took 77 milliseconds
Apr 15 19:01:56 volumio volumio[948]: info: sendMpdCommand playlistinfo took 77 milliseconds
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:56 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: 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":"(#1 - 7/200) Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:56 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:56 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: 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":"(#1 - 7/200) Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:56 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:56 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: 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":"(#1 - 7/200) Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:56 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:56 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:56 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 197ms
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 192ms
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 192ms
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:57 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:57 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:57 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:57 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 23ms
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand status took 22 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 22ms
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand status took 20 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 20ms
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand status took 18 milliseconds
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:57 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:57 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:57 volumio volumio[948]: info:
Apr 15 19:01:57 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 46ms
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand status took 43 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand playlistinfo took 37 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand playlistinfo took 36 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand playlistinfo took 37 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 35ms
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand status took 34 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 33ms
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand status took 32 milliseconds
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:57 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:57 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Phillip Wilkerson - Deep Flow","artist":"Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:57 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:57 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:57 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:57 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Phillip Wilkerson - Deep Flow","artist":"Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:57 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:57 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:57 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:57 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Phillip Wilkerson - Deep Flow","artist":"Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:57 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:57 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 167ms
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 166ms
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 165ms
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand playlistinfo took 131 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand playlistinfo took 131 milliseconds
Apr 15 19:01:57 volumio volumio[948]: info: sendMpdCommand playlistinfo took 130 milliseconds
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:57 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:57 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:57 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Phillip Wilkerson - Deep Flow","artist":"Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:57 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:57 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:57 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:57 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Phillip Wilkerson - Deep Flow","artist":"Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:57 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:57 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:57 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:57 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Phillip Wilkerson - Deep Flow","artist":"Drone Radio (MRG.fm)","album":null,"uri":"http://62.149.196.16:8070/stream","trackType":""}
Apr 15 19:01:57 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:57 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:57 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 276ms
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 266ms
Apr 15 19:01:57 volumio volumio[948]: info: ------------------------------ 264ms
Apr 15 19:01:58 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::ClearQueue
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::serviceStop
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::serviceStop
Apr 15 19:01:58 volumio volumio[948]: info: [1713196918234] ControllerWebradio::stop
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::clearPlayQueue
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::addQueueItems
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::addQueueItems
Apr 15 19:01:58 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:01:58 volumio volumio[948]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99591180
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPlay
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::play index 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: [1713196918267] ControllerWebradio::clearAddPlayTrack
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand stop took 43 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand stop took 12 milliseconds
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand clear took 7 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99591180"
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 50ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 49ms
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: error: updateQueue error: null
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 53ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 49 milliseconds
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 62ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99591180" took 156 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 121ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 119ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand play took 7 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 11ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 5ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 3ms
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 10 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: 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":"(#1 - 5/500) ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: 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":"(#1 - 5/500) ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: 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":"(#1 - 5/500) ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 52ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 100ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 98ms
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 84 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 82 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 83 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: 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":"(#1 - 5/500) ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: 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":"(#1 - 5/500) ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: 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":"(#1 - 5/500) ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 226ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 219ms
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 219ms
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 185ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 184 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 15ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 13 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 12ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 11 milliseconds
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:01:58 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:01:58 volumio volumio[948]: info:
Apr 15 19:01:58 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 55ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 51 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 47 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 46 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand playlistinfo took 45 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 44ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 41 milliseconds
Apr 15 19:01:58 volumio volumio[948]: info: ------------------------------ 40ms
Apr 15 19:01:58 volumio volumio[948]: info: sendMpdCommand status took 38 milliseconds
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:01:58 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Abacus Rain - Heavy Rain with Thunderstorm","artist":"ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Abacus Rain - Heavy Rain with Thunderstorm","artist":"ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:58 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:58 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Abacus Rain - Heavy Rain with Thunderstorm","artist":"ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:58 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:58 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:58 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:59 volumio volumio[948]: info: ------------------------------ 380ms
Apr 15 19:01:59 volumio volumio[948]: info: ------------------------------ 209ms
Apr 15 19:01:59 volumio volumio[948]: info: ------------------------------ 207ms
Apr 15 19:01:59 volumio volumio[948]: info: sendMpdCommand playlistinfo took 151 milliseconds
Apr 15 19:01:59 volumio volumio[948]: info: sendMpdCommand playlistinfo took 151 milliseconds
Apr 15 19:01:59 volumio volumio[948]: info: sendMpdCommand playlistinfo took 150 milliseconds
Apr 15 19:01:59 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:59 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:59 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:01:59 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:59 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:59 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Abacus Rain - Heavy Rain with Thunderstorm","artist":"ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:59 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:59 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:59 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:59 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:59 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Abacus Rain - Heavy Rain with Thunderstorm","artist":"ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:59 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:59 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:59 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:01:59 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:01:59 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"64 Kbps","isStreaming":false,"title":"Abacus Rain - Heavy Rain with Thunderstorm","artist":"ABACUS RAIN","album":null,"uri":"http://54.38.44.70:8004/stream","trackType":""}
Apr 15 19:01:59 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:01:59 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:01:59 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:01:59 volumio volumio[948]: info: ------------------------------ 313ms
Apr 15 19:01:59 volumio volumio[948]: info: ------------------------------ 301ms
Apr 15 19:01:59 volumio volumio[948]: info: ------------------------------ 297ms
Apr 15 19:02:00 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::ClearQueue
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::serviceStop
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::serviceStop
Apr 15 19:02:00 volumio volumio[948]: info: [1713196920524] ControllerWebradio::stop
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::clearPlayQueue
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::addQueueItems
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::addQueueItems
Apr 15 19:02:00 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:02:00 volumio volumio[948]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540204
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::volumioPlay
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::play index 0
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: [1713196920561] ControllerWebradio::clearAddPlayTrack
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand stop took 48 milliseconds
Apr 15 19:02:00 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand stop took 12 milliseconds
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:00 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:00 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:00 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand status took 9 milliseconds
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand clear took 8 milliseconds
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540204"
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:00 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:02:00 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:00 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:00 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 43ms
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 42ms
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:00 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:00 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:00 volumio volumio[948]: error: updateQueue error: null
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 54ms
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand playlistinfo took 51 milliseconds
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:00 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 65ms
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99540204" took 136 milliseconds
Apr 15 19:02:00 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 15 19:02:00 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:00 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 99ms
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 97ms
Apr 15 19:02:00 volumio volumio[948]: info: sendMpdCommand play took 4 milliseconds
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:00 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:00 volumio volumio[948]: info:
Apr 15 19:02:00 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:00 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 10ms
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 6ms
Apr 15 19:02:00 volumio volumio[948]: info: ------------------------------ 4ms
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 10 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 7 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: 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":"(#1 - 2/100) Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: 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":"(#1 - 2/100) Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: 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":"(#1 - 2/100) Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 55ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 97ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 95ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 74 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 73 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 73 milliseconds
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: 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":"(#1 - 2/100) Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: 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":"(#1 - 2/100) Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: 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":"(#1 - 2/100) Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 198ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 193ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 193ms
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:02 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:02 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:02 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:02 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 20ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 19 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 15ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 14 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 13ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 11 milliseconds
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:02 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:02 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:02 volumio volumio[948]: info:
Apr 15 19:02:02 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 39ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 37 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 34 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 34 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 33 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 31ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 30 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 28ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand status took 26 milliseconds
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1103,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Natural White Noise - Music for Meditation, Relaxation, Sleep - Rainforest Soundscapes: Soothing Rain, Thunderstorms, Waterfalls","artist":"Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1103,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Natural White Noise - Music for Meditation, Relaxation, Sleep - Rainforest Soundscapes: Soothing Rain, Thunderstorms, Waterfalls","artist":"Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1103,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Natural White Noise - Music for Meditation, Relaxation, Sleep - Rainforest Soundscapes: Soothing Rain, Thunderstorms, Waterfalls","artist":"Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 167ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 163ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 161ms
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 132 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 130 milliseconds
Apr 15 19:02:02 volumio volumio[948]: info: sendMpdCommand playlistinfo took 131 milliseconds
Apr 15 19:02:02 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1103,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Natural White Noise - Music for Meditation, Relaxation, Sleep - Rainforest Soundscapes: Soothing Rain, Thunderstorms, Waterfalls","artist":"Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1103,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Natural White Noise - Music for Meditation, Relaxation, Sleep - Rainforest Soundscapes: Soothing Rain, Thunderstorms, Waterfalls","artist":"Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:02 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:02 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1103,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Natural White Noise - Music for Meditation, Relaxation, Sleep - Rainforest Soundscapes: Soothing Rain, Thunderstorms, Waterfalls","artist":"Earth Radio","album":null,"uri":"https://jenny.torontocast.com:8044/stream","trackType":""}
Apr 15 19:02:02 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:02 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:02 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 317ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 309ms
Apr 15 19:02:02 volumio volumio[948]: info: ------------------------------ 306ms
Apr 15 19:02:03 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioReplaceandPlayItems
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::ClearQueue
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::stPlaybackTimer
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::serviceStop
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::serviceStop
Apr 15 19:02:03 volumio volumio[948]: info: [1713196923347] ControllerWebradio::stop
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::clearPlayQueue
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::addQueueItems
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::addQueueItems
Apr 15 19:02:03 volumio volumio[948]: info: Preload queue cleared
Apr 15 19:02:03 volumio volumio[948]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99546102
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushQueue
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::saveQueue
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::updateTrackBlock
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrackBlock
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPlay
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::play index 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::stop
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::play index undefined
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService undefined
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::startPlaybackTimer
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: [1713196923379] ControllerWebradio::clearAddPlayTrack
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand stop
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand stop took 40 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand stop took 8 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand clear
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 8 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand clear took 6 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99546102"
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 24ms
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 24ms
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: error: updateQueue error: null
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 28ms
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 25 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 38ms
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99546102" took 168 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 150ms
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 149ms
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::setConsumeUpdateService mpd
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand play
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 15ms
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand play took 12 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 11ms
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 4ms
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 7 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 3 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 11 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 9 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 8 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 5 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 4 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: 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":"(#1 - 1/100) EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus stop
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: 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":"(#1 - 1/100) EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: 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":"(#1 - 1/100) EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 43ms
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 50ms
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 49ms
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 41 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 39 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 40 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: 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":"(#1 - 1/100) EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: 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":"(#1 - 1/100) EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: 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":"(#1 - 1/100) EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 94ms
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 90ms
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 88ms
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces system playlist update
Apr 15 19:02:03 volumio volumio[948]: info: Ignoring MPD Status Update
Apr 15 19:02:03 volumio volumio[948]: info:
Apr 15 19:02:03 volumio volumio[948]: ---------------------------- MPD announces state update: player
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::getState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand status
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 20ms
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 18 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 17ms
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 16 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: ------------------------------ 15ms
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand status took 6 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseState
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 6 milliseconds
Apr 15 19:02:03 volumio volumio[948]: info: sendMpdCommand playlistinfo took 5 milliseconds
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: verbose: ControllerMpd::parseTrackInfo
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Theta Wave Orchestra - Afon Ether II","artist":"EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Theta Wave Orchestra - Afon Ether II","artist":"EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: ControllerMpd::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::servicePushState
Apr 15 19:02:03 volumio volumio[948]: info: CorePlayQueue::getTrack 0
Apr 15 19:02:03 volumio volumio[948]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Theta Wave Orchestra - Afon Ether II","artist":"EarthSong Meditation Radio","album":null,"uri":"http://65.108.124.70:8598/stream","trackType":""}
Apr 15 19:02:03 volumio volumio[948]: verbose: CURRENT POSITION 0
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState stateService play
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::syncState currentStatus play
Apr 15 19:02:03 volumio volumio[948]: info: Received an update from plugin. extracting info from payload
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreStateMachine::pushState
Apr 15 19:02:03 volumio volumio[948]: info: CoreCommandRouter::volumioPushState
Apr 15 19:02:04 volumio volumio[948]: info: ------------------------------ 98ms
Apr 15 19:02:04 volumio volumio[948]: info: ------------------------------ 97ms
Apr 15 19:02:04 volumio volumio[948]: info: ------------------------------ 96ms
Apr 15 19:02:21 volumio volumio[948]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Apr 15 19:02:38 volumio volumio[948]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 15 19:02:39 volumio volumio[948]: Error: getaddrinfo ENOTFOUND lastfm.freetls.fastly.net
Apr 15 19:02:39 volumio volumio[948]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:71:26) {
Apr 15 19:02:39 volumio volumio[948]: errno: -3007,
Apr 15 19:02:39 volumio volumio[948]: code: 'ENOTFOUND',
Apr 15 19:02:39 volumio volumio[948]: syscall: 'getaddrinfo',
Apr 15 19:02:39 volumio volumio[948]: hostname: 'lastfm.freetls.fastly.net'
Apr 15 19:02:39 volumio volumio[948]: }
Apr 15 19:02:39 volumio volumio[948]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 15 19:02:40 volumio sudo[2195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-04-15 19:01
Apr 15 19:02:40 volumio sudo[2195]: pam_unix(sudo:session): session opened for user root by (uid=0)
PRETTY_NAME="Debian GNU/Linux 10 (buster)"
NAME="Debian GNU/Linux"
VERSION_ID="10"
VERSION="10 (buster)"
VERSION_CODENAME=buster
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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="armv7"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat 24 Feb 2024 08:17:12 PM CET"
VOLUMIO_VERSION="3.629"
VOLUMIO_HARDWARE="orangepilite"
VOLUMIO_DEVICENAME="Orange Pi Lite"
VOLUMIO_HASH="93172cde15f9cd6d224d9962d74c8bf3"