-- Logs begin at Sun 2025-01-19 09:11:10 CST, end at Sun 2025-01-19 09:48:49 CST. --
Jan 19 09:47:00 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::ClearQueue
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::stPlaybackTimer
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::serviceStop
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::serviceStop
Jan 19 09:47:00 volumio volumio[2816]: info: [1737251220761] ControllerWebradio::stop
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::clearPlayQueue
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::addQueueItems
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::addQueueItems
Jan 19 09:47:00 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:00 volumio volumio[2816]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99545298
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPlay
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::play index 0
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::play index undefined
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::startPlaybackTimer
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: [1737251220765] ControllerWebradio::clearAddPlayTrack
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:47:00 volumio volumio[2816]: info:
Jan 19 09:47:00 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:00 volumio volumio[2816]: info: sendMpdCommand stop took 8 milliseconds
Jan 19 09:47:00 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:00 volumio volumio[2816]: info: sendMpdCommand stop took 5 milliseconds
Jan 19 09:47:00 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clear
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:00 volumio volumio[2816]: info:
Jan 19 09:47:00 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:00 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:00 volumio volumio[2816]: info:
Jan 19 09:47:00 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:00 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:00 volumio volumio[2816]: info:
Jan 19 09:47:00 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:00 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:00 volumio volumio[2816]: info: sendMpdCommand clear took 2 milliseconds
Jan 19 09:47:00 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:47:00 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:00 volumio volumio[2816]: info: sendMpdCommand status took 0 milliseconds
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99545298"
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:00 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:00 volumio volumio[2816]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jan 19 09:47:00 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 19 09:47:00 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:00 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:00 volumio volumio[2816]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 19 09:47:00 volumio volumio[2816]: info: ------------------------------ 7ms
Jan 19 09:47:00 volumio volumio[2816]: info: ------------------------------ 6ms
Jan 19 09:47:00 volumio volumio[2816]: info: ------------------------------ 6ms
Jan 19 09:47:00 volumio volumio[2816]: info:
Jan 19 09:47:00 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:00 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:00 volumio volumio[2816]: info:
Jan 19 09:47:00 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:00 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:00 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:47:00 volumio volumio[2816]: info: ------------------------------ 8ms
Jan 19 09:47:01 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::ClearQueue
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::clearPlayQueue
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::addQueueItems
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::addQueueItems
Jan 19 09:47:01 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:01 volumio volumio[2816]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99545298
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPlay
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::play index 0
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::play index undefined
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::startPlaybackTimer
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:01 volumio volumio[2816]: info: [1737251221059] ControllerWebradio::clearAddPlayTrack
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99545298" took 305 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand play
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 302ms
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 301ms
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand stop took 20 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clear
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand play took 3 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand clear took 1 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99545298"
Jan 19 09:47:01 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:01 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:01 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:47:01 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: No code
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 8ms
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:01 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:01 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99545298" took 302 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand play
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 295ms
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand status took 294 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 294ms
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand status took 294 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:01 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:01 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:01 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:47:01 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: No code
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:01 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:47:01 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: No code
Jan 19 09:47:01 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:01 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 305ms
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 304ms
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info:
Jan 19 09:47:01 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:01 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:01 volumio volumio[2816]: info: sendMpdCommand play took 13 milliseconds
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:47:01 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 10 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: 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 - 25/9999) Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: 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 - 25/9999) Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: 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 - 25/9999) Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 22ms
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 23ms
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 23ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 11 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: 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 - 25/9999) Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: 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 - 25/9999) Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: 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 - 25/9999) Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 26ms
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 25ms
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 24ms
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 6ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 6 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 5ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 4 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"stream","artist":"Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 28ms
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 26ms
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 25ms
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:02 volumio volumio[2816]: info:
Jan 19 09:47:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Aitana - Quieres","artist":"Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 13ms
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 19 09:47:02 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Aitana - Quieres","artist":"Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:02 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1229,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Aitana - Quieres","artist":"Radio Fm Latina Chile 89.1","album":null,"uri":"http://62.171.162.249:8034/stream","trackType":""}
Jan 19 09:47:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:02 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 24ms
Jan 19 09:47:02 volumio volumio[2816]: info: ------------------------------ 23ms
Jan 19 09:47:09 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 19 09:47:09 volumio volumio[2816]: info: TuneIn handleBrowseUri: tunein/local
Jan 19 09:47:31 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jan 19 09:47:31 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:34 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::ClearQueue
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::stPlaybackTimer
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::serviceStop
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::serviceStop
Jan 19 09:47:34 volumio volumio[2816]: info: [1737251254776] ControllerWebradio::stop
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::clearPlayQueue
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::addQueueItems
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::addQueueItems
Jan 19 09:47:34 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:34 volumio volumio[2816]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::volumioPlay
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::play index 0
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::play index undefined
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::startPlaybackTimer
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: [1737251254783] ControllerWebradio::clearAddPlayTrack
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:47:34 volumio volumio[2816]: info:
Jan 19 09:47:34 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:34 volumio volumio[2816]: info: sendMpdCommand stop took 9 milliseconds
Jan 19 09:47:34 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:34 volumio volumio[2816]: info: sendMpdCommand stop took 2 milliseconds
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clear
Jan 19 09:47:34 volumio volumio[2816]: info:
Jan 19 09:47:34 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:34 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:34 volumio volumio[2816]: info:
Jan 19 09:47:34 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:34 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:34 volumio volumio[2816]: info:
Jan 19 09:47:34 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:34 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:34 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:34 volumio volumio[2816]: info: sendMpdCommand clear took 2 milliseconds
Jan 19 09:47:34 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:34 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996"
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:34 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 19 09:47:34 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:34 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:34 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:34 volumio volumio[2816]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jan 19 09:47:34 volumio volumio[2816]: info: ------------------------------ 7ms
Jan 19 09:47:34 volumio volumio[2816]: info: ------------------------------ 6ms
Jan 19 09:47:34 volumio volumio[2816]: info:
Jan 19 09:47:34 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:34 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:34 volumio volumio[2816]: info:
Jan 19 09:47:34 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:34 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:34 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:47:34 volumio volumio[2816]: info: ------------------------------ 7ms
Jan 19 09:47:34 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jan 19 09:47:34 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:34 volumio volumio[2816]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jan 19 09:47:34 volumio volumio[2816]: info: ------------------------------ 10ms
Jan 19 09:47:35 volumio volumio[2816]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 303 milliseconds
Jan 19 09:47:35 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 19 09:47:35 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand play
Jan 19 09:47:35 volumio volumio[2816]: info:
Jan 19 09:47:35 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:35 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:35 volumio volumio[2816]: info: ------------------------------ 300ms
Jan 19 09:47:35 volumio volumio[2816]: info: ------------------------------ 300ms
Jan 19 09:47:35 volumio volumio[2816]: info:
Jan 19 09:47:35 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:35 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:35 volumio volumio[2816]: info:
Jan 19 09:47:35 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:35 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:35 volumio volumio[2816]: info: sendMpdCommand play took 6 milliseconds
Jan 19 09:47:35 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:47:35 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 11 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 10 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 9 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: 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":"antenne","artist":"(#1 - 5783/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: 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":"antenne","artist":"(#1 - 5783/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: 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":"antenne","artist":"(#1 - 5783/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 23ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 25ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 25ms
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: 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":"antenne","artist":"(#1 - 5783/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 23ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: 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":"antenne","artist":"(#1 - 5783/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: 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":"antenne","artist":"(#1 - 5783/500000) ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 22ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 22ms
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 11ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 11 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 11ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 11 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 11ms
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":216,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":307,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 28ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 27ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 19ms
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:38 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:38 volumio volumio[2816]: info:
Jan 19 09:47:38 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 16ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 16 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 13 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 30ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 30ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 27ms
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 14 milliseconds
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:38 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:38 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":978,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:38 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:38 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:38 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 38ms
Jan 19 09:47:38 volumio volumio[2816]: info: ------------------------------ 23ms
Jan 19 09:47:39 volumio volumio[2816]: info:
Jan 19 09:47:39 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:39 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:39 volumio volumio[2816]: info:
Jan 19 09:47:39 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:39 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:39 volumio volumio[2816]: info:
Jan 19 09:47:39 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:39 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:39 volumio volumio[2816]: info:
Jan 19 09:47:39 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:39 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:39 volumio volumio[2816]: info:
Jan 19 09:47:39 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:39 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:39 volumio volumio[2816]: info:
Jan 19 09:47:39 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:39 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:39 volumio volumio[2816]: info: ------------------------------ 5ms
Jan 19 09:47:39 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:39 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:39 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:39 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:47:39 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:39 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:47:39 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:47:39 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:39 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:39 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:39 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:39 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:39 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:39 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:39 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:39 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:39 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:39 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:39 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:39 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:39 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:39 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:39 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:39 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:39 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:39 volumio volumio[2816]: info: ------------------------------ 13ms
Jan 19 09:47:39 volumio volumio[2816]: info: ------------------------------ 13ms
Jan 19 09:47:39 volumio volumio[2816]: info: ------------------------------ 12ms
Jan 19 09:47:40 volumio volumio[2816]: info:
Jan 19 09:47:40 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:40 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:40 volumio volumio[2816]: info:
Jan 19 09:47:40 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:40 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:40 volumio volumio[2816]: info:
Jan 19 09:47:40 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:40 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:40 volumio volumio[2816]: info:
Jan 19 09:47:40 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:40 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:40 volumio volumio[2816]: info:
Jan 19 09:47:40 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:40 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:40 volumio volumio[2816]: info:
Jan 19 09:47:40 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:40 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:40 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:47:40 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:40 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:47:40 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:40 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:40 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:40 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jan 19 09:47:40 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:40 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:40 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:40 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:40 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3361,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:40 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:40 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:40 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:40 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:40 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3361,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:40 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:40 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:40 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:40 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:40 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3361,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Mike & The Mechanics - Everybody Gets A Second Chance","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""}
Jan 19 09:47:40 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:47:40 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:40 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:40 volumio volumio[2816]: info: ------------------------------ 16ms
Jan 19 09:47:40 volumio volumio[2816]: info: ------------------------------ 15ms
Jan 19 09:47:50 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::ClearQueue
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::stPlaybackTimer
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::serviceStop
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::serviceStop
Jan 19 09:47:50 volumio volumio[2816]: info: [1737251270192] ControllerWebradio::stop
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::clearPlayQueue
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::addQueueItems
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::addQueueItems
Jan 19 09:47:50 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:47:50 volumio volumio[2816]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99570654
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPlay
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::play index 0
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::play index undefined
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::startPlaybackTimer
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:50 volumio volumio[2816]: info: [1737251270197] ControllerWebradio::clearAddPlayTrack
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:47:50 volumio volumio[2816]: info:
Jan 19 09:47:50 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand stop took 6 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand stop took 1 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clear
Jan 19 09:47:50 volumio volumio[2816]: info:
Jan 19 09:47:50 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:50 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand clear took 1 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99570654"
Jan 19 09:47:50 volumio volumio[2816]: info:
Jan 19 09:47:50 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:50 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:50 volumio volumio[2816]: info:
Jan 19 09:47:50 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:50 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:50 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:47:50 volumio volumio[2816]: info: ------------------------------ 2ms
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:50 volumio volumio[2816]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jan 19 09:47:50 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99570654" took 302 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand play
Jan 19 09:47:50 volumio volumio[2816]: info:
Jan 19 09:47:50 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:50 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:50 volumio volumio[2816]: info:
Jan 19 09:47:50 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:50 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:50 volumio volumio[2816]: info:
Jan 19 09:47:50 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:47:50 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand status took 303 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand status took 302 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: info: sendMpdCommand play took 2 milliseconds
Jan 19 09:47:50 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:47:50 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:50 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:50 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:47:50 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:50 volumio volumio[2816]: info: No code
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:50 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:50 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:50 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:47:50 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:50 volumio volumio[2816]: info: No code
Jan 19 09:47:50 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:50 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:50 volumio volumio[2816]: info: ------------------------------ 315ms
Jan 19 09:47:50 volumio volumio[2816]: info: ------------------------------ 315ms
Jan 19 09:47:50 volumio volumio[2816]: info: ------------------------------ 14ms
Jan 19 09:47:50 volumio volumio[2816]: info: ------------------------------ 13ms
Jan 19 09:47:51 volumio volumio[2816]: info:
Jan 19 09:47:51 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:51 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:51 volumio volumio[2816]: info:
Jan 19 09:47:51 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:51 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:51 volumio volumio[2816]: info:
Jan 19 09:47:51 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:47:51 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand status took 2 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clearerror
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand status took 5 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand clearerror took 3 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand clearerror took 3 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:51 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:51 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 120/1000) Radio Trapanele Manele Noi - www.RadioTrapanele.ro","album":null,"uri":"https://54.39.28.158:8132/stream","trackType":""}
Jan 19 09:47:51 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: No code
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:51 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 120/1000) Radio Trapanele Manele Noi - www.RadioTrapanele.ro","album":null,"uri":"https://54.39.28.158:8132/stream","trackType":""}
Jan 19 09:47:51 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: No code
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: ------------------------------ 16ms
Jan 19 09:47:51 volumio volumio[2816]: info: ------------------------------ 15ms
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand clearerror took 13 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jan 19 09:47:51 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:47:51 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:47:51 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 120/1000) Radio Trapanele Manele Noi - www.RadioTrapanele.ro","album":null,"uri":"https://54.39.28.158:8132/stream","trackType":""}
Jan 19 09:47:51 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: No code
Jan 19 09:47:51 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:47:51 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:47:51 volumio volumio[2816]: info: ------------------------------ 23ms
Jan 19 09:48:00 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:48:00 volumio volumio[2816]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::ClearQueue
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:00 volumio volumio[2816]: info: CorePlayQueue::clearPlayQueue
Jan 19 09:48:00 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:48:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::addQueueItems
Jan 19 09:48:00 volumio volumio[2816]: info: CorePlayQueue::addQueueItems
Jan 19 09:48:00 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:48:00 volumio volumio[2816]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1912054
Jan 19 09:48:00 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 19 09:48:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:48:00 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:48:00 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:48:00 volumio volumio[2816]: info: CoreCommandRouter::volumioPlay
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::play index 0
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::play index undefined
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:00 volumio volumio[2816]: info: CoreStateMachine::startPlaybackTimer
Jan 19 09:48:00 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:00 volumio volumio[2816]: info: [1737251280137] ControllerWebradio::clearAddPlayTrack
Jan 19 09:48:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:48:00 volumio volumio[2816]: info: sendMpdCommand stop took 1 milliseconds
Jan 19 09:48:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clear
Jan 19 09:48:00 volumio volumio[2816]: info: sendMpdCommand clear took 1 milliseconds
Jan 19 09:48:00 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1912054"
Jan 19 09:48:00 volumio volumio[2816]: info:
Jan 19 09:48:00 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:00 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:00 volumio volumio[2816]: info:
Jan 19 09:48:00 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:00 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:00 volumio volumio[2816]: info:
Jan 19 09:48:00 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:00 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::ClearQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::clearPlayQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::addQueueItems
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::addQueueItems
Jan 19 09:48:02 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:48:02 volumio volumio[2816]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1872491
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPlay
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::play index 0
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::play index undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::startPlaybackTimer
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:02 volumio volumio[2816]: info: [1737251282379] ControllerWebradio::clearAddPlayTrack
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:48:02 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::ClearQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::clearPlayQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::addQueueItems
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::addQueueItems
Jan 19 09:48:02 volumio volumio[2816]: info: Preload queue cleared
Jan 19 09:48:02 volumio volumio[2816]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1872491
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::saveQueue
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::updateTrackBlock
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::getTrackBlock
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPlay
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::play index 0
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::stop
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::play index undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService undefined
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::startPlaybackTimer
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:02 volumio volumio[2816]: info: [1737251282593] ControllerWebradio::clearAddPlayTrack
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand stop
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1912054" took 2849 milliseconds
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand play
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 2850ms
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 2849ms
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 2850ms
Jan 19 09:48:02 volumio volumio[2816]: info: sendMpdCommand stop took 611 milliseconds
Jan 19 09:48:02 volumio volumio[2816]: info: sendMpdCommand stop took 397 milliseconds
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:48:02 volumio volumio[2816]: info: sendMpdCommand play took 2 milliseconds
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clear
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand clear
Jan 19 09:48:02 volumio volumio[2816]: Upnp client error: Error: This socket has been ended by the other party
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:48:02 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:48:02 volumio volumio[2816]: info: sendMpdCommand clear took 2 milliseconds
Jan 19 09:48:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:02 volumio volumio[2816]: info: sendMpdCommand clear took 2 milliseconds
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 1ms
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1872491"
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1872491"
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:02 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:02 volumio volumio[2816]: info:
Jan 19 09:48:02 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:02 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:02 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:48:02 volumio volumio[2816]: error: updateQueue error: null
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:48:02 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:48:02 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:48:02 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:02 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:02 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:02 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:48:02 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:02 volumio volumio[2816]: info: No code
Jan 19 09:48:02 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:02 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 8ms
Jan 19 09:48:03 volumio volumio[2816]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1872491" took 304 milliseconds
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 19 09:48:03 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand play
Jan 19 09:48:03 volumio volumio[2816]: info:
Jan 19 09:48:03 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:03 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:03 volumio volumio[2816]: info:
Jan 19 09:48:03 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:03 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:03 volumio volumio[2816]: info:
Jan 19 09:48:03 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:03 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:03 volumio volumio[2816]: info:
Jan 19 09:48:03 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:03 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:03 volumio volumio[2816]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1872491" took 608 milliseconds
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 608ms
Jan 19 09:48:03 volumio volumio[2816]: info: sendMpdCommand status took 608 milliseconds
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 607ms
Jan 19 09:48:03 volumio volumio[2816]: info: sendMpdCommand status took 607 milliseconds
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::setConsumeUpdateService mpd
Jan 19 09:48:03 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand play
Jan 19 09:48:03 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:03 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:03 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:03 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:03 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:48:03 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:03 volumio volumio[2816]: info: No code
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:03 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:03 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:03 volumio volumio[2816]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null}
Jan 19 09:48:03 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::syncState stateService stop
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:03 volumio volumio[2816]: info: No code
Jan 19 09:48:03 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:03 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 620ms
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 619ms
Jan 19 09:48:03 volumio volumio[2816]: info:
Jan 19 09:48:03 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:03 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:03 volumio volumio[2816]: info:
Jan 19 09:48:03 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:03 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:03 volumio volumio[2816]: info: sendMpdCommand play took 321 milliseconds
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 18ms
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 17ms
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 17ms
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 16ms
Jan 19 09:48:03 volumio volumio[2816]: info: sendMpdCommand play took 14 milliseconds
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:48:03 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 10 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 9 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 9 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 1 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: 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":"89.238.227.6:8042","artist":"(#1 - 127/3000) Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus stop
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: 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":"89.238.227.6:8042","artist":"(#1 - 127/3000) Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: 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":"89.238.227.6:8042","artist":"(#1 - 127/3000) Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 18ms
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 20ms
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 21ms
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 10 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 9 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: 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":"89.238.227.6:8042","artist":"(#1 - 127/3000) Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: 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":"89.238.227.6:8042","artist":"(#1 - 127/3000) Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: 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":"89.238.227.6:8042","artist":"(#1 - 127/3000) Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 26ms
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 24ms
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 24ms
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:04 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:04 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces system playlist update
Jan 19 09:48:04 volumio volumio[2816]: info: Ignoring MPD Status Update
Jan 19 09:48:04 volumio volumio[2816]: info:
Jan 19 09:48:04 volumio volumio[2816]: ---------------------------- MPD announces state update: player
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::getState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand status
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 3ms
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 3 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 4ms
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand status took 4 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseState
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jan 19 09:48:04 volumio volumio[2816]: verbose: ControllerMpd::parseTrackInfo
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":307,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"89.238.227.6:8042","artist":"Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":330,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"89.238.227.6:8042","artist":"Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ControllerMpd::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::servicePushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: verbose: STATE SERVICE {"status":"play","position":0,"seek":409,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"256 Kbps","isStreaming":false,"title":"89.238.227.6:8042","artist":"Antena Satelor","album":null,"uri":"http://89.238.227.6:8042","trackType":"6:8042"}
Jan 19 09:48:04 volumio volumio[2816]: verbose: CURRENT POSITION 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState stateService play
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::syncState currentStatus play
Jan 19 09:48:04 volumio volumio[2816]: info: Received an update from plugin. extracting info from payload
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CorePlayQueue::getTrack 0
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreStateMachine::pushState
Jan 19 09:48:04 volumio volumio[2816]: info: CoreCommandRouter::volumioPushState
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 17ms
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 18ms
Jan 19 09:48:04 volumio volumio[2816]: info: ------------------------------ 17ms
Jan 19 09:48:49 volumio volumio[2816]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 19 09:48:49 volumio volumio[2816]: Error: connect ETIMEDOUT 31.13.84.2:80
Jan 19 09:48:49 volumio volumio[2816]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jan 19 09:48:49 volumio volumio[2816]: errno: -110,
Jan 19 09:48:49 volumio volumio[2816]: code: 'ETIMEDOUT',
Jan 19 09:48:49 volumio volumio[2816]: syscall: 'connect',
Jan 19 09:48:49 volumio volumio[2816]: address: '31.13.84.2',
Jan 19 09:48:49 volumio volumio[2816]: port: 80
Jan 19 09:48:49 volumio volumio[2816]: }
Jan 19 09:48:49 volumio volumio[2816]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jan 19 09:48:49 volumio sudo[9952]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-19 09:47
Jan 19 09:48:49 volumio sudo[9952]: 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="70bcab5180cf11352f5a5197ade215ea8ee93db0"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET"
VOLUMIO_VERSION="3.779"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"