-- Logs begin at Tue 2024-07-23 11:15:23 UTC, end at Tue 2024-07-23 13:48:59 UTC. --
Jul 23 13:47:01 volumio volumio[13856]: info: CoreCommandRouter::volumioPlay
Jul 23 13:47:01 volumio volumio[13856]: info: CoreStateMachine::play index undefined
Jul 23 13:47:01 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:01 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:01 volumio volumio[13856]: info: CoreStateMachine::startPlaybackTimer
Jul 23 13:47:01 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:01 volumio volumio[13856]: info: [1721742421153] ControllerWebradio::clearAddPlayTrack
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand stop
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand stop took 2 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand clear
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:01 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:01 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:01 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand clear took 1 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664"
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:01 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:01 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:01 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:01 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:01 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:01 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:01 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 3ms
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:01 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:01 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:01 volumio volumio[13856]: error: updateQueue error: null
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand status took 3 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 2ms
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:01 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:01 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:01 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:01 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:01 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:01 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:01 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:01 volumio volumio[13856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 6ms
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 6ms
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:01 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" took 245 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 23 13:47:01 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand play
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 244ms
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 244ms
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:01 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:01 volumio volumio[13856]: info:
Jul 23 13:47:01 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:01 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:01 volumio volumio[13856]: info: sendMpdCommand play took 2 milliseconds
Jul 23 13:47:01 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:02 volumio volumio[13856]: info:
Jul 23 13:47:02 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:02 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:02 volumio volumio[13856]: info:
Jul 23 13:47:02 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:02 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:02 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:02 volumio volumio[13856]: info:
Jul 23 13:47:02 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:02 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:02 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:02 volumio volumio[13856]: info: ------------------------------ 0ms
Jul 23 13:47:06 volumio volumio[13856]: info:
Jul 23 13:47:06 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:06 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:06 volumio volumio[13856]: info:
Jul 23 13:47:06 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:06 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:06 volumio volumio[13856]: info:
Jul 23 13:47:06 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:06 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:06 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:06 volumio volumio[13856]: info: ------------------------------ 2ms
Jul 23 13:47:07 volumio volumio[13856]: info:
Jul 23 13:47:07 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:07 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:07 volumio volumio[13856]: info:
Jul 23 13:47:07 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:07 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:07 volumio volumio[13856]: info:
Jul 23 13:47:07 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:07 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:07 volumio volumio[13856]: info: ------------------------------ 2ms
Jul 23 13:47:07 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:07 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:08 volumio volumio[13856]: info: CoreCommandRouter::volumioPlay
Jul 23 13:47:08 volumio volumio[13856]: info: CoreStateMachine::play index undefined
Jul 23 13:47:08 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:08 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:08 volumio volumio[13856]: info: CoreStateMachine::startPlaybackTimer
Jul 23 13:47:08 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:08 volumio volumio[13856]: info: [1721742428729] ControllerWebradio::clearAddPlayTrack
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand stop
Jul 23 13:47:08 volumio volumio[13856]: info:
Jul 23 13:47:08 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:08 volumio volumio[13856]: info: sendMpdCommand stop took 2 milliseconds
Jul 23 13:47:08 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand clear
Jul 23 13:47:08 volumio volumio[13856]: info:
Jul 23 13:47:08 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:08 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:08 volumio volumio[13856]: info:
Jul 23 13:47:08 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:08 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:08 volumio volumio[13856]: info:
Jul 23 13:47:08 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:08 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:08 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:08 volumio volumio[13856]: info: sendMpdCommand clear took 1 milliseconds
Jul 23 13:47:08 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:08 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664"
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:08 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:08 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:08 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:08 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:08 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:08 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:08 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:08 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:08 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:08 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:08 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:08 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:08 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:08 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:08 volumio volumio[13856]: info: ------------------------------ 3ms
Jul 23 13:47:08 volumio volumio[13856]: info: ------------------------------ 3ms
Jul 23 13:47:08 volumio volumio[13856]: info:
Jul 23 13:47:08 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:08 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:08 volumio volumio[13856]: info:
Jul 23 13:47:08 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:08 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:08 volumio volumio[13856]: error: updateQueue error: null
Jul 23 13:47:08 volumio volumio[13856]: info: ------------------------------ 3ms
Jul 23 13:47:08 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 23 13:47:08 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:08 volumio volumio[13856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 23 13:47:08 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPlay
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::play index undefined
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:09 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::startPlaybackTimer
Jul 23 13:47:09 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:09 volumio volumio[13856]: info: [1721742429457] ControllerWebradio::clearAddPlayTrack
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand stop
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" took 959 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand play
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 958ms
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand stop took 235 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand clear
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:09 volumio volumio[13856]: error: updateQueue error: null
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand play took 1 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand clear took 0 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 0ms
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664"
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:09 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:09 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:09 volumio volumio[13856]: error: updateQueue error: null
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 2ms
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand status took 2 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:09 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:09 volumio volumio[13856]: 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}
Jul 23 13:47:09 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::syncState stateService stop
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus stop
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: No code
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1728664" took 244 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand play
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 244ms
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand status took 244 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 244ms
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand status took 243 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 2ms
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:09 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:09 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:09 volumio volumio[13856]: 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}
Jul 23 13:47:09 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::syncState stateService stop
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus stop
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: No code
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:09 volumio volumio[13856]: 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}
Jul 23 13:47:09 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::syncState stateService stop
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus stop
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: No code
Jul 23 13:47:09 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:09 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 249ms
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 250ms
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info:
Jul 23 13:47:09 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:09 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:09 volumio volumio[13856]: info: sendMpdCommand play took 8 milliseconds
Jul 23 13:47:09 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:11 volumio volumio[13856]: info: Preload queue cleared
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::volumioReplaceandPlayItems
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::ClearQueue
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::stop
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::clearPlayQueue
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::saveQueue
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::volumioPushQueue
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::addQueueItems
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::addQueueItems
Jul 23 13:47:11 volumio volumio[13856]: info: Preload queue cleared
Jul 23 13:47:11 volumio volumio[13856]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497984
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::volumioPushQueue
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::saveQueue
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::updateTrackBlock
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::getTrackBlock
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::volumioPlay
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::play index 0
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::stop
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::play index undefined
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::startPlaybackTimer
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:11 volumio volumio[13856]: info: [1721742431585] ControllerWebradio::clearAddPlayTrack
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand stop
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand stop took 2 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand clear
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:11 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:11 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:11 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand clear took 1 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand status took 0 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand status took 0 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497984"
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:11 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:11 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:11 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:11 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:11 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:11 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:11 volumio volumio[13856]: info: ------------------------------ 3ms
Jul 23 13:47:11 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:11 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:11 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:11 volumio volumio[13856]: error: updateQueue error: null
Jul 23 13:47:11 volumio volumio[13856]: info: ------------------------------ 5ms
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:11 volumio volumio[13856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 23 13:47:11 volumio volumio[13856]: info: ------------------------------ 7ms
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:11 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497984" took 245 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: info: ------------------------------ 242ms
Jul 23 13:47:11 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 23 13:47:11 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand play
Jul 23 13:47:11 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:11 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:11 volumio volumio[13856]: info:
Jul 23 13:47:11 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:11 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:11 volumio volumio[13856]: info: sendMpdCommand play took 1 milliseconds
Jul 23 13:47:11 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:12 volumio volumio[13856]: info: CoreCommandRouter::volumioPlay
Jul 23 13:47:12 volumio volumio[13856]: info: CoreStateMachine::play index undefined
Jul 23 13:47:12 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:12 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:12 volumio volumio[13856]: info: CoreStateMachine::startPlaybackTimer
Jul 23 13:47:12 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:12 volumio volumio[13856]: info: [1721742432809] ControllerWebradio::clearAddPlayTrack
Jul 23 13:47:12 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand stop
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand stop took 708 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand clear
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand clear took 1 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand status took 0 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand status took 0 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497984"
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 3ms
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 3ms
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: error: updateQueue error: null
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:13 volumio volumio[13856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 5ms
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497984" took 244 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 242ms
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 241ms
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand play
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand play took 0 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 0ms
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::volumioPlay
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::play index undefined
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService undefined
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::startPlaybackTimer
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: [1721742433901] ControllerWebradio::clearAddPlayTrack
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand stop
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand stop took 1 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand clear
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand clear took 1 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand status took 0 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497984"
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:13 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:13 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:13 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:13 volumio volumio[13856]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: info:
Jul 23 13:47:13 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:13 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:13 volumio volumio[13856]: error: updateQueue error: null
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:13 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 23 13:47:13 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:13 volumio volumio[13856]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined
Jul 23 13:47:13 volumio volumio[13856]: info: ------------------------------ 5ms
Jul 23 13:47:14 volumio volumio[13856]: info:
Jul 23 13:47:14 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:14 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:14 volumio volumio[13856]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497984" took 248 milliseconds
Jul 23 13:47:14 volumio volumio[13856]: info: CoreStateMachine::setConsumeUpdateService mpd
Jul 23 13:47:14 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand play
Jul 23 13:47:14 volumio volumio[13856]: info: ------------------------------ 246ms
Jul 23 13:47:14 volumio volumio[13856]: info: ------------------------------ 246ms
Jul 23 13:47:14 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:14 volumio volumio[13856]: info:
Jul 23 13:47:14 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:14 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:14 volumio volumio[13856]: info:
Jul 23 13:47:14 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:14 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:14 volumio volumio[13856]: info: sendMpdCommand play took 1 milliseconds
Jul 23 13:47:14 volumio volumio[13856]: info: ------------------------------ 0ms
Jul 23 13:47:14 volumio volumio[13856]: info: ------------------------------ 0ms
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 6 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 6 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 0 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: 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":"rockantenne-oesterreich","artist":"(#1 - 364/500000) ROCK ANTENNE ?sterreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus stop
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: 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":"rockantenne-oesterreich","artist":"(#1 - 364/500000) ROCK ANTENNE ?sterreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: 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":"rockantenne-oesterreich","artist":"(#1 - 364/500000) ROCK ANTENNE ?sterreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 11ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 12ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 13ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 6 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 5 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: 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":"rockantenne-oesterreich","artist":"(#1 - 364/500000) ROCK ANTENNE ?sterreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: 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":"rockantenne-oesterreich","artist":"(#1 - 364/500000) ROCK ANTENNE ?sterreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 13ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 12ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 8 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: 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":"rockantenne-oesterreich","artist":"(#1 - 364/500000) ROCK ANTENNE ?sterreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 16ms
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 2 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 2 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":204,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":295,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 7ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 8ms
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 6ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 6 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 6ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 6 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 0 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: 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":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 11ms
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:16 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:16 volumio volumio[13856]: info:
Jul 23 13:47:16 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 6 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 7 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 4 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand status took 4 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 23ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 23ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 18ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 18ms
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 12 milliseconds
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:16 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:16 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:16 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:16 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:16 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 20ms
Jul 23 13:47:16 volumio volumio[13856]: info: ------------------------------ 21ms
Jul 23 13:47:17 volumio volumio[13856]: info:
Jul 23 13:47:17 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:17 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:17 volumio volumio[13856]: info:
Jul 23 13:47:17 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:17 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:17 volumio volumio[13856]: info:
Jul 23 13:47:17 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:17 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:17 volumio volumio[13856]: info:
Jul 23 13:47:17 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:17 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:17 volumio volumio[13856]: info:
Jul 23 13:47:17 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:17 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:17 volumio volumio[13856]: info:
Jul 23 13:47:17 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:17 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:17 volumio volumio[13856]: info: ------------------------------ 2ms
Jul 23 13:47:17 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:17 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:17 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:17 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:17 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:17 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 23 13:47:17 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 1 milliseconds
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:17 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:17 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:17 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:17 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:17 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:17 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:17 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:17 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:17 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:17 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:17 volumio volumio[13856]: info: ------------------------------ 6ms
Jul 23 13:47:17 volumio volumio[13856]: info: ------------------------------ 5ms
Jul 23 13:47:17 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 3 milliseconds
Jul 23 13:47:17 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:17 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:17 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:17 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1981,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:17 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:17 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:17 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:17 volumio volumio[13856]: info: ------------------------------ 7ms
Jul 23 13:47:18 volumio volumio[13856]: info:
Jul 23 13:47:18 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:18 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:18 volumio volumio[13856]: info:
Jul 23 13:47:18 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:18 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:18 volumio volumio[13856]: info:
Jul 23 13:47:18 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:18 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:18 volumio volumio[13856]: info:
Jul 23 13:47:18 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:18 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:18 volumio volumio[13856]: info:
Jul 23 13:47:18 volumio volumio[13856]: ---------------------------- MPD announces system playlist update
Jul 23 13:47:18 volumio volumio[13856]: info: Ignoring MPD Status Update
Jul 23 13:47:18 volumio volumio[13856]: info:
Jul 23 13:47:18 volumio volumio[13856]: ---------------------------- MPD announces state update: player
Jul 23 13:47:18 volumio volumio[13856]: info: ControllerMpd::getState
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand status
Jul 23 13:47:18 volumio volumio[13856]: info: ------------------------------ 2ms
Jul 23 13:47:18 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:18 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:18 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:18 volumio volumio[13856]: info: ------------------------------ 1ms
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:18 volumio volumio[13856]: info: sendMpdCommand status took 1 milliseconds
Jul 23 13:47:18 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 0 milliseconds
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::parseState
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::sendMpdCommand playlistinfo
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:18 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:18 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:18 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3486,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:18 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:18 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:18 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:18 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:18 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3486,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:18 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:18 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:18 volumio volumio[13856]: info: ------------------------------ 4ms
Jul 23 13:47:18 volumio volumio[13856]: info: ------------------------------ 5ms
Jul 23 13:47:18 volumio volumio[13856]: info: sendMpdCommand playlistinfo took 4 milliseconds
Jul 23 13:47:18 volumio volumio[13856]: verbose: ControllerMpd::parseTrackInfo
Jul 23 13:47:18 volumio volumio[13856]: info: ControllerMpd::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::servicePushState
Jul 23 13:47:18 volumio volumio[13856]: info: CorePlayQueue::getTrack 0
Jul 23 13:47:18 volumio volumio[13856]: verbose: STATE SERVICE {"status":"play","position":0,"seek":3486,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Don Henley - The Boys Of Summer","artist":"ROCK ANTENNE Österreich","album":null,"uri":"http://stream.antenne.de:80/rockantenne-oesterreich","trackType":""}
Jul 23 13:47:18 volumio volumio[13856]: verbose: CURRENT POSITION 0
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::syncState stateService play
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::syncState currentStatus play
Jul 23 13:47:18 volumio volumio[13856]: info: Received an update from plugin. extracting info from payload
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:18 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:47:18 volumio volumio[13856]: info: ------------------------------ 6ms
Jul 23 13:47:43 volumio volumio[13856]: info: VolumeController::SetAlsaVolume64
Jul 23 13:47:43 volumio volumio[13856]: info: CoreStateMachine::pushState
Jul 23 13:47:43 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jul 23 13:47:43 volumio volumio[13856]: info: CoreCommandRouter::volumioPushState
Jul 23 13:48:27 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri
Jul 23 13:48:27 volumio volumio[13856]: info: Preload queue cleared
Jul 23 13:48:31 volumio nmbd[969]: [2024/07/23 13:48:31.139755, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response)
Jul 23 13:48:31 volumio nmbd[969]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.1.50 for name WORKGROUP<1d>.
Jul 23 13:48:31 volumio nmbd[969]: This response was from IP 192.168.1.1, reporting an IP address of 192.168.1.1.
Jul 23 13:48:35 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 23 13:48:35 volumio volumio[13856]: info: Preload queue cleared
Jul 23 13:48:43 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 23 13:48:43 volumio volumio[13856]: info: TuneIn handleBrowseUri: tunein/location
Jul 23 13:48:46 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 23 13:48:46 volumio volumio[13856]: info: TuneIn handleBrowseUri: tunein/location
Jul 23 13:48:52 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 23 13:48:52 volumio volumio[13856]: info: TuneIn handleBrowseUri: tunein/popular
Jul 23 13:48:53 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 23 13:48:53 volumio volumio[13856]: info: TuneIn handleBrowseUri: tunein/popular
Jul 23 13:48:54 volumio volumio[13856]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri
Jul 23 13:48:54 volumio volumio[13856]: info: TuneIn handleBrowseUri: tunein/popular
Jul 23 13:48:59 volumio volumio[13856]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 23 13:48:59 volumio volumio[13856]: Error: connect ETIMEDOUT 168.143.171.186:80
Jul 23 13:48:59 volumio volumio[13856]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) {
Jul 23 13:48:59 volumio volumio[13856]: errno: -110,
Jul 23 13:48:59 volumio volumio[13856]: code: 'ETIMEDOUT',
Jul 23 13:48:59 volumio volumio[13856]: syscall: 'connect',
Jul 23 13:48:59 volumio volumio[13856]: address: '168.143.171.186',
Jul 23 13:48:59 volumio volumio[13856]: port: 80
Jul 23 13:48:59 volumio volumio[13856]: }
Jul 23 13:48:59 volumio volumio[13856]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jul 23 13:48:59 volumio sudo[19724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-23 13:47
Jul 23 13:48:59 volumio sudo[19724]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720"
VOLUMIO_ARCH="x64"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 09:13:11 PM CEST"
VOLUMIO_VERSION="3.703"
VOLUMIO_HARDWARE="x86_amd64"
VOLUMIO_DEVICENAME="x86_64"
VOLUMIO_HASH="ac782621640fcc70c07e91a81b6d958b"