-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Sat 2026-02-21 16:10:05 CET. -- Feb 21 16:09:01 albertino go-librespot[1272]: time="2026-02-21T16:09:01+01:00" level=trace msg="sent dealer ping" Feb 21 16:09:01 albertino go-librespot[1272]: time="2026-02-21T16:09:01+01:00" level=trace msg="received dealer pong" Feb 21 16:09:01 albertino kernel: hwmon hwmon1: Undervoltage detected! Feb 21 16:09:04 albertino volumio[999]: info: CoreCommandRouter::volumioNext Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::next Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::stop Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::play index undefined Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:04 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::startPlaybackTimer Feb 21 16:09:04 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:04 albertino volumio[999]: info: [1771686544059] ControllerWebradio::clearAddPlayTrack Feb 21 16:09:04 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::updateTrackBlock Feb 21 16:09:04 albertino volumio[999]: info: CorePlayQueue::getTrackBlock Feb 21 16:09:04 albertino volumio[999]: info: sendMpdCommand stop took 1 milliseconds Feb 21 16:09:04 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 16:09:04 albertino volumio[999]: info: sendMpdCommand clear took 0 milliseconds Feb 21 16:09:04 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand load "https://eu1.fastcast4u.com/proxy/antena2000?mp=/1" Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand add "https://eu1.fastcast4u.com/proxy/antena2000?mp=/1" Feb 21 16:09:04 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:04 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:04 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:04 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 635ms Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 633ms Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 633ms Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 632ms Feb 21 16:09:04 albertino volumio[999]: info: sendMpdCommand add "https://eu1.fastcast4u.com/proxy/antena2000?mp=/1" took 5 milliseconds Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 16:09:04 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand play Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: info: Feb 21 16:09:04 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:04 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 14ms Feb 21 16:09:04 albertino volumio[999]: info: sendMpdCommand play took 12 milliseconds Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 10ms Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 8ms Feb 21 16:09:04 albertino volumio[999]: info: ------------------------------ 6ms Feb 21 16:09:04 albertino volumio[999]: info: CoreCommandRouter::volumioNext Feb 21 16:09:04 albertino volumio[999]: info: CoreStateMachine::next Feb 21 16:09:04 albertino volumio[999]: info: ControllerMpd::next Feb 21 16:09:04 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand next Feb 21 16:09:05 albertino volumio[999]: info: sendMpdCommand next took 430 milliseconds Feb 21 16:09:05 albertino volumio[999]: info: Feb 21 16:09:05 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:05 albertino volumio[999]: info: Feb 21 16:09:05 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:05 albertino volumio[999]: info: Feb 21 16:09:05 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:05 albertino volumio[999]: info: Feb 21 16:09:05 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:05 albertino volumio[999]: info: sendMpdCommand status took 9 milliseconds Feb 21 16:09:05 albertino volumio[999]: info: sendMpdCommand status took 7 milliseconds Feb 21 16:09:05 albertino volumio[999]: info: sendMpdCommand status took 5 milliseconds Feb 21 16:09:05 albertino volumio[999]: info: sendMpdCommand status took 3 milliseconds Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:05 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:05 albertino volumio[999]: 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} Feb 21 16:09:05 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState stateService stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: No code Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:05 albertino volumio[999]: 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} Feb 21 16:09:05 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState stateService stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: No code Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:05 albertino volumio[999]: 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} Feb 21 16:09:05 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState stateService stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: No code Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:05 albertino volumio[999]: 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} Feb 21 16:09:05 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState stateService stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus stop Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: No code Feb 21 16:09:05 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:05 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:05 albertino volumio[999]: info: ------------------------------ 280ms Feb 21 16:09:05 albertino volumio[999]: info: ------------------------------ 279ms Feb 21 16:09:05 albertino volumio[999]: info: ------------------------------ 279ms Feb 21 16:09:05 albertino volumio[999]: info: ------------------------------ 278ms Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:05 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:09 albertino kernel: hwmon hwmon1: Voltage normalised Feb 21 16:09:11 albertino kernel: hwmon hwmon1: Undervoltage detected! Feb 21 16:09:16 albertino kernel: hwmon hwmon1: Voltage normalised Feb 21 16:09:20 albertino kernel: hwmon hwmon1: Undervoltage detected! Feb 21 16:09:24 albertino kernel: hwmon hwmon1: Voltage normalised Feb 21 16:09:30 albertino kernel: hwmon hwmon1: Undervoltage detected! Feb 21 16:09:31 albertino go-librespot[1272]: time="2026-02-21T16:09:31+01:00" level=trace msg="sent dealer ping" Feb 21 16:09:31 albertino go-librespot[1272]: time="2026-02-21T16:09:31+01:00" level=trace msg="received dealer pong" Feb 21 16:09:35 albertino volumio[999]: info: Preload queue cleared Feb 21 16:09:35 albertino volumio[999]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::ClearQueue Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::stop Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:35 albertino volumio[999]: info: CorePlayQueue::clearPlayQueue Feb 21 16:09:35 albertino volumio[999]: info: CorePlayQueue::saveQueue Feb 21 16:09:35 albertino volumio[999]: info: CoreCommandRouter::volumioPushQueue Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::addQueueItems Feb 21 16:09:35 albertino volumio[999]: info: CorePlayQueue::addQueueItems Feb 21 16:09:35 albertino volumio[999]: info: Preload queue cleared Feb 21 16:09:35 albertino volumio[999]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s266585 Feb 21 16:09:35 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 16:09:35 albertino volumio[999]: info: CoreCommandRouter::volumioPushQueue Feb 21 16:09:35 albertino volumio[999]: info: CorePlayQueue::saveQueue Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::updateTrackBlock Feb 21 16:09:35 albertino volumio[999]: info: CorePlayQueue::getTrackBlock Feb 21 16:09:35 albertino volumio[999]: info: CoreCommandRouter::volumioPlay Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::play index 0 Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::stop Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::play index undefined Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:35 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:35 albertino volumio[999]: info: CoreStateMachine::startPlaybackTimer Feb 21 16:09:35 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:35 albertino volumio[999]: info: [1771686575613] ControllerWebradio::clearAddPlayTrack Feb 21 16:09:35 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 16:09:35 albertino volumio[999]: info: sendMpdCommand stop took 6 milliseconds Feb 21 16:09:35 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 16:09:35 albertino volumio[999]: info: sendMpdCommand clear took 1 milliseconds Feb 21 16:09:35 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand load "http://s2.radio.co/sd9da54aa0/listen" Feb 21 16:09:35 albertino volumio[999]: info: Feb 21 16:09:35 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:35 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:35 albertino volumio[999]: info: Feb 21 16:09:35 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:35 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:35 albertino volumio[999]: info: Feb 21 16:09:35 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:35 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:35 albertino volumio[999]: info: Feb 21 16:09:35 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:35 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand add "http://s2.radio.co/sd9da54aa0/listen" Feb 21 16:09:36 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:36 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:36 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 860ms Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 858ms Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 856ms Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 854ms Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:36 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand add "http://s2.radio.co/sd9da54aa0/listen" took 10 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand play Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:36 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:36 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:36 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 20ms Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand play took 18 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 17ms Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 15ms Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 12ms Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 21 16:09:36 albertino volumio[999]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 21 16:09:36 albertino volumio[999]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 38 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 37 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 36 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 35 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: info: Feb 21 16:09:36 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 16 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand playlistinfo took 15 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand playlistinfo took 16 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 12 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 21 milliseconds Feb 21 16:09:36 albertino volumio[999]: info: sendMpdCommand status took 18 milliseconds Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:36 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:36 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:36 albertino volumio[999]: 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":"listen","artist":null,"album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:36 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus stop Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:36 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:36 albertino volumio[999]: 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":"listen","artist":null,"album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:36 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:36 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:36 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:36 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:36 albertino volumio[999]: 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":"listen","artist":null,"album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:36 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:36 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:36 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:36 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:36 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:36 albertino volumio[999]: 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":"listen","artist":null,"album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:36 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:36 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:36 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:36 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:36 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:36 albertino volumio[999]: info: ------------------------------ 135ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 259ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 257ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 257ms Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 195 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 192 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 191 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 191 milliseconds Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: 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":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: 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":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: 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":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: 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":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 438ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 428ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 426ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 426ms Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 288ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 285 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 288ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 284 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 72ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 70 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 69ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 68 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 67ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 66 milliseconds Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:37 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:37 albertino volumio[999]: info: Feb 21 16:09:37 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 17 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 18 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 16ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 16 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 14ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 13 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 12ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand status took 11 milliseconds Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2109,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2109,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2109,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 561ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 561ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 347ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 344ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 342ms Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 254 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 255 milliseconds Feb 21 16:09:37 albertino volumio[999]: info: sendMpdCommand playlistinfo took 255 milliseconds Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2235,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2235,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:37 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:37 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2235,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Dj VYKT - VYKT o'clock 3","artist":"Barcelona city radio","album":null,"uri":"http://s2.radio.co/sd9da54aa0/listen","trackType":""} Feb 21 16:09:37 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:37 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:37 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 453ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 451ms Feb 21 16:09:37 albertino volumio[999]: info: ------------------------------ 449ms Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:37 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:49 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 16:09:49 albertino volumio[999]: info: Preload queue cleared Feb 21 16:09:51 albertino ntpd[787]: 212.6.50.243 local addr 192.168.1.7 -> Feb 21 16:09:51 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Feb 21 16:09:52 albertino volumio[999]: info: Preload queue cleared Feb 21 16:09:53 albertino volumio[999]: info: Preload queue cleared Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::ClearQueue Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::stop Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::stPlaybackTimer Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::updateTrackBlock Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrackBlock Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::serviceStop Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::serviceStop Feb 21 16:09:53 albertino volumio[999]: info: [1771686593465] ControllerWebradio::stop Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::clearPlayQueue Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::saveQueue Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioPushQueue Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::addQueueItems Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::addQueueItems Feb 21 16:09:53 albertino volumio[999]: info: Preload queue cleared Feb 21 16:09:53 albertino volumio[999]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioPushQueue Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::saveQueue Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::updateTrackBlock Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrackBlock Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioPlay Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::play index 0 Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::stop Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::play index undefined Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::startPlaybackTimer Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: [1771686593512] ControllerWebradio::clearAddPlayTrack Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 16:09:53 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand stop took 65 milliseconds Feb 21 16:09:53 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand stop took 17 milliseconds Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:53 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:53 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:53 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:53 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand status took 12 milliseconds Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand clear took 10 milliseconds Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand status took 9 milliseconds Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand status took 7 milliseconds Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand status took 6 milliseconds Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:53 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 16:09:53 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 16:09:53 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:53 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:53 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:53 albertino volumio[999]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 16:09:53 albertino volumio[999]: info: ------------------------------ 99ms Feb 21 16:09:53 albertino volumio[999]: info: ------------------------------ 98ms Feb 21 16:09:53 albertino volumio[999]: info: ------------------------------ 97ms Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:53 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:53 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:53 albertino volumio[999]: info: Feb 21 16:09:53 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:53 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:53 albertino volumio[999]: error: updateQueue error: null Feb 21 16:09:53 albertino volumio[999]: info: ------------------------------ 107ms Feb 21 16:09:53 albertino volumio[999]: info: sendMpdCommand playlistinfo took 102 milliseconds Feb 21 16:09:53 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:53 albertino volumio[999]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 21 16:09:53 albertino volumio[999]: info: ------------------------------ 122ms Feb 21 16:09:53 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:53 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:53 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:54 albertino volumio[999]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 783 milliseconds Feb 21 16:09:54 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 16:09:54 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand play Feb 21 16:09:54 albertino volumio[999]: info: Feb 21 16:09:54 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:54 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:54 albertino volumio[999]: info: ------------------------------ 698ms Feb 21 16:09:54 albertino volumio[999]: info: ------------------------------ 697ms Feb 21 16:09:54 albertino volumio[999]: info: ------------------------------ 695ms Feb 21 16:09:54 albertino volumio[999]: info: Feb 21 16:09:54 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:54 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:54 albertino volumio[999]: info: Feb 21 16:09:54 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:54 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:54 albertino volumio[999]: info: Feb 21 16:09:54 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:54 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:54 albertino volumio[999]: info: sendMpdCommand play took 16 milliseconds Feb 21 16:09:54 albertino volumio[999]: info: ------------------------------ 14ms Feb 21 16:09:54 albertino volumio[999]: info: ------------------------------ 10ms Feb 21 16:09:54 albertino volumio[999]: info: ------------------------------ 8ms Feb 21 16:09:54 albertino volumio[999]: info: ------------------------------ 6ms Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 21 16:09:56 albertino volumio[999]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 21 16:09:56 albertino volumio[999]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 41 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 40 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 38 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 37 milliseconds Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:56 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 24 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand playlistinfo took 22 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand playlistinfo took 21 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand playlistinfo took 21 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand playlistinfo took 22 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 18 milliseconds Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:56 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus stop Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:56 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:56 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:56 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:56 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"antenne","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:56 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:56 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: ------------------------------ 149ms Feb 21 16:09:56 albertino volumio[999]: info: ------------------------------ 278ms Feb 21 16:09:56 albertino volumio[999]: info: ------------------------------ 278ms Feb 21 16:09:56 albertino volumio[999]: info: ------------------------------ 277ms Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:56 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:56 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:56 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:56 albertino volumio[999]: info: Feb 21 16:09:56 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 238 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 237 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: ------------------------------ 233ms Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand status took 231 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand playlistinfo took 224 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:56 albertino volumio[999]: info: sendMpdCommand playlistinfo took 221 milliseconds Feb 21 16:09:56 albertino volumio[999]: info: ------------------------------ 15ms Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:56 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":80,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:56 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:56 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:56 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:56 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":617,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:56 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:56 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:56 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:56 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 398ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 388ms Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:57 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:57 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:57 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 225 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 223ms Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 218 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 222ms Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 215 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 214 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 213 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 213 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 75ms Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 73 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 69ms Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 67 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 65ms Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 65 milliseconds Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":762,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1288,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1356,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 625ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 624ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 619ms Feb 21 16:09:57 albertino volumio[999]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:57 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:09:57 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:09:57 albertino volumio[999]: info: Feb 21 16:09:57 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 184 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 183 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 184 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 182 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 183 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 182 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 19ms Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 18 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 17ms Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand status took 11 milliseconds Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1985,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1985,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1985,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2111,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 694ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 692ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 692ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 544ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 538ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 537ms Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 357 milliseconds Feb 21 16:09:57 albertino volumio[999]: info: sendMpdCommand playlistinfo took 358 milliseconds Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2362,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:09:57 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:09:57 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":2362,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Imagine Dragons - Radioactive","artist":"ANTENNE BAYERN","album":null,"uri":"http://stream.antenne.de:80/antenne","trackType":""} Feb 21 16:09:57 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:09:57 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:09:57 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 505ms Feb 21 16:09:57 albertino volumio[999]: info: ------------------------------ 504ms Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:09:57 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:01 albertino go-librespot[1272]: time="2026-02-21T16:10:01+01:00" level=trace msg="received accesspoint ping" Feb 21 16:10:01 albertino go-librespot[1272]: time="2026-02-21T16:10:01+01:00" level=trace msg="received accesspoint pong ack" Feb 21 16:10:01 albertino go-librespot[1272]: time="2026-02-21T16:10:01+01:00" level=trace msg="sent dealer ping" Feb 21 16:10:01 albertino go-librespot[1272]: time="2026-02-21T16:10:01+01:00" level=trace msg="received dealer pong" Feb 21 16:10:01 albertino volumio[999]: info: Preload queue cleared Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioReplaceandPlayItems Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::ClearQueue Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::stop Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::stPlaybackTimer Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::updateTrackBlock Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrackBlock Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::serviceStop Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::serviceStop Feb 21 16:10:01 albertino volumio[999]: info: [1771686601769] ControllerWebradio::stop Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::clearPlayQueue Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::saveQueue Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioPushQueue Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::addQueueItems Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::addQueueItems Feb 21 16:10:01 albertino volumio[999]: info: Preload queue cleared Feb 21 16:10:01 albertino volumio[999]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320 Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioPushQueue Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::saveQueue Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::updateTrackBlock Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrackBlock Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioPlay Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::play index 0 Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::stop Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::play index undefined Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService undefined Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::startPlaybackTimer Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: [1771686601812] ControllerWebradio::clearAddPlayTrack Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand stop Feb 21 16:10:01 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand stop took 55 milliseconds Feb 21 16:10:01 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand stop took 12 milliseconds Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand clear Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:01 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:01 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:01 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand status took 12 milliseconds Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand clear took 11 milliseconds Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand status took 11 milliseconds Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand status took 8 milliseconds Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:01 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 16:10:01 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 73ms Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 72ms Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: error: updateQueue error: null Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand status took 76 milliseconds Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 73ms Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand playlistinfo took 69 milliseconds Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:01 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:01 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:01 albertino volumio[999]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Feb 21 16:10:01 albertino volumio[999]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 107ms Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 115ms Feb 21 16:10:01 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:01 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:01 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99568320" took 120 milliseconds Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 59ms Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 57ms Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 56ms Feb 21 16:10:01 albertino volumio[999]: info: CoreStateMachine::setConsumeUpdateService mpd Feb 21 16:10:01 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand play Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: info: Feb 21 16:10:01 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:01 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 15ms Feb 21 16:10:01 albertino volumio[999]: info: sendMpdCommand play took 11 milliseconds Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 9ms Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 8ms Feb 21 16:10:01 albertino volumio[999]: info: ------------------------------ 5ms Feb 21 16:10:02 albertino kernel: bcm2835_audio bcm2835_audio: failed to close VCHI service connection (status=-11) Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: FusionDsp - ---- read samplerate, raw: Feb 21 16:10:03 albertino volumio[999]: error: FusionDsp - invalid sample rate Feb 21 16:10:03 albertino volumio[999]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Feb 21 16:10:03 albertino volumio[999]: info: FusionDsp - ---- read samplerate from file: 44100 Feb 21 16:10:03 albertino volumio[999]: info: FusionDsp - If filter freq >samplerate/2 then disable it Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 36 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 34 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 32 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 31 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:03 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 25 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 26 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 25 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 25 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 20 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 18 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 16 milliseconds Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: 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":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus stop Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: 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":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: 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":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: 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":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 126ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 254ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 254ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 252ms Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:03 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:03 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces system playlist update Feb 21 16:10:03 albertino volumio[999]: info: Ignoring MPD Status Update Feb 21 16:10:03 albertino volumio[999]: info: Feb 21 16:10:03 albertino volumio[999]: ---------------------------- MPD announces state update: player Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::getState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand status Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 220ms Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 211 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 206 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 202 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 203 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 203 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 18ms Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 17 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 15ms Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 14 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 13ms Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand status took 11 milliseconds Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseState Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::sendMpdCommand playlistinfo Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":605,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1102,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1216,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1227,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 454ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 447ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 444ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 443ms Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 281 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 280 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 279 milliseconds Feb 21 16:10:03 albertino volumio[999]: info: sendMpdCommand playlistinfo took 280 milliseconds Feb 21 16:10:03 albertino volumio[999]: verbose: ControllerMpd::parseTrackInfo Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1604,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ControllerMpd::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::servicePushState Feb 21 16:10:03 albertino volumio[999]: info: CorePlayQueue::getTrack 0 Feb 21 16:10:03 albertino volumio[999]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"112 Kbps","isStreaming":false,"title":"Tracklist: https://dancewave.online","artist":"Dance Wave!","album":null,"uri":"https://dancewave.online:443/dance.mp3","trackType":"mp3"} Feb 21 16:10:03 albertino volumio[999]: verbose: CURRENT POSITION 0 Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState stateService play Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::syncState currentStatus play Feb 21 16:10:03 albertino volumio[999]: info: Received an update from plugin. extracting info from payload Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: CoreStateMachine::pushState Feb 21 16:10:03 albertino volumio[999]: info: CoreCommandRouter::volumioPushState Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 696ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 492ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 490ms Feb 21 16:10:03 albertino volumio[999]: info: ------------------------------ 488ms Feb 21 16:10:03 albertino volumio[999]: info: FusionDsp - {"Reload":{"result":"Ok"}} Feb 21 16:10:03 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:04 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:04 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:04 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:04 albertino volumio[999]: SPOTIFY: RECEIVED VOLUMIO VOLUME 100 Feb 21 16:10:04 albertino volumio[999]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 16:10:04 albertino volumio[999]: TypeError: Cannot read property 'slice' of null Feb 21 16:10:04 albertino volumio[999]: at download (/volumio/app/plugins/miscellanea/albumart/albumart.js:718:41) Feb 21 16:10:04 albertino volumio[999]: at ClientRequest. (/volumio/app/plugins/miscellanea/albumart/albumart.js:728:7) Feb 21 16:10:04 albertino volumio[999]: at Object.onceWrapper (events.js:422:26) Feb 21 16:10:04 albertino volumio[999]: at ClientRequest.emit (events.js:315:20) Feb 21 16:10:04 albertino volumio[999]: at HTTPParser.parserOnIncomingClient [as onIncoming] (_http_client.js:641:27) Feb 21 16:10:04 albertino volumio[999]: at HTTPParser.parserOnHeadersComplete (_http_common.js:126:17) Feb 21 16:10:04 albertino volumio[999]: at TLSSocket.socketOnData (_http_client.js:509:22) Feb 21 16:10:04 albertino volumio[999]: at TLSSocket.emit (events.js:315:20) Feb 21 16:10:04 albertino volumio[999]: at addChunk (internal/streams/readable.js:309:12) Feb 21 16:10:04 albertino volumio[999]: at readableAddChunk (internal/streams/readable.js:284:9) Feb 21 16:10:04 albertino volumio[999]: at TLSSocket.Readable.push (internal/streams/readable.js:223:10) Feb 21 16:10:04 albertino volumio[999]: at TLSWrap.onStreamRead (internal/stream_base_commons.js:188:23) Feb 21 16:10:04 albertino volumio[999]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 21 16:10:05 albertino sudo[3479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-02-21 16:09 Feb 21 16:10:05 albertino sudo[3479]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="e9612ec5034fb2e958508aaefbca2962fd6f6654" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 05 Feb 2026 01:46:18 PM CET" VOLUMIO_VERSION="3.908" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3e9dbaf8f44792d26e97456a18f12823"