-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Tue 2025-03-11 13:16:10 CET. -- Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 11 13:15:10 dar-1000es volumio[728]: info: Discovery: Getting this device information Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:10 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::stPlaybackTimer Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::serviceStop Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::serviceStop Mar 11 13:15:10 dar-1000es volumio[728]: info: [1741695310723] ControllerWebradio::stop Mar 11 13:15:10 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::addQueueItems Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::addQueueItems Mar 11 13:15:10 dar-1000es volumio[728]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s231678 Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 11 13:15:10 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:10 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:10 dar-1000es volumio[728]: info: Mar 11 13:15:10 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:10 dar-1000es volumio[728]: info: sendMpdCommand stop took 114 milliseconds Mar 11 13:15:10 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:10 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioClearQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:10 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:10 dar-1000es volumio[728]: info: sendMpdCommand status took 33 milliseconds Mar 11 13:15:10 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:10 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:10 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:10 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:10 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 11 13:15:10 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:10 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:10 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Nelson Vaz - 8 Am","artist":"Lounge Radio Deluxe (VIP)","album":null,"uri":"https://loungeradiodeluxe-rex.radioca.st/stream","trackType":"st/stream"} Mar 11 13:15:10 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService stop Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:10 dar-1000es volumio[728]: info: No code Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:10 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:10 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:10 dar-1000es volumio[728]: info: ------------------------------ 96ms Mar 11 13:15:10 dar-1000es volumio[728]: info: Mar 11 13:15:10 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:10 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:10 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:10 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:10 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:10 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:10 dar-1000es volumio[728]: info: ------------------------------ 47ms Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:11 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:11 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:11 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:11 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::startPlaybackTimer Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: [1741695311199] ControllerWebradio::clearAddPlayTrack Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand stop took 3 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand clear Mar 11 13:15:11 dar-1000es volumio[728]: info: Mar 11 13:15:11 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:11 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand clear took 1 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand load "http://cdn-cms.tunein.com/service/Audio/nostream.enUS.mp3" Mar 11 13:15:11 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:11 dar-1000es volumio[728]: info: ------------------------------ 3ms Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand add "http://cdn-cms.tunein.com/service/Audio/nostream.enUS.mp3" Mar 11 13:15:11 dar-1000es volumio[728]: info: Mar 11 13:15:11 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:11 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand add "http://cdn-cms.tunein.com/service/Audio/nostream.enUS.mp3" took 2 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand play Mar 11 13:15:11 dar-1000es volumio[728]: info: ------------------------------ 3ms Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand play took 1 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: Mar 11 13:15:11 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:11 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:11 dar-1000es kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand status took 62 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:11 dar-1000es volumio[728]: info: Mar 11 13:15:11 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:11 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand status took 2 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:11 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:11 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":13,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"24 Kbps","isStreaming":false,"title":"nostream.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/nostream.enUS.mp3","trackType":"mp3"} Mar 11 13:15:11 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:11 dar-1000es volumio[728]: info: ------------------------------ 80ms Mar 11 13:15:11 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 11 milliseconds Mar 11 13:15:11 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:11 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:11 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":882,"duration":13,"samplerate":"16 kHz","bitdepth":"24 bit","channels":1,"random":false,"updatedb":false,"repeat":false,"bitrate":"24 Kbps","isStreaming":false,"title":"nostream.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/nostream.enUS.mp3","trackType":"mp3"} Mar 11 13:15:11 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:11 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:11 dar-1000es volumio[728]: info: ------------------------------ 44ms Mar 11 13:15:11 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:11 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:11 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:11 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:12 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:13 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:14 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:15 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:16 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:17 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::stPlaybackTimer Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::serviceStop Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::serviceStop Mar 11 13:15:17 dar-1000es volumio[728]: info: [1741695317795] ControllerWebradio::stop Mar 11 13:15:17 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::addQueueItems Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::addQueueItems Mar 11 13:15:17 dar-1000es volumio[728]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s223154 Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 11 13:15:17 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:17 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:17 dar-1000es volumio[728]: info: Mar 11 13:15:17 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:17 dar-1000es volumio[728]: info: sendMpdCommand stop took 100 milliseconds Mar 11 13:15:17 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:17 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioClearQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:17 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:17 dar-1000es volumio[728]: info: sendMpdCommand status took 21 milliseconds Mar 11 13:15:17 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:17 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:17 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:17 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:17 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 17 milliseconds Mar 11 13:15:17 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:17 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:17 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"nostream.enUS.mp3","artist":null,"album":null,"uri":"http://cdn-cms.tunein.com/service/Audio/nostream.enUS.mp3","trackType":"mp3"} Mar 11 13:15:17 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService stop Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:17 dar-1000es volumio[728]: info: No code Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:17 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:17 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:17 dar-1000es volumio[728]: info: ------------------------------ 70ms Mar 11 13:15:17 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:17 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:17 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:18 dar-1000es volumio[728]: info: Mar 11 13:15:18 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:18 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:18 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:18 dar-1000es volumio[728]: info: ------------------------------ 5ms Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:18 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:18 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:18 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:18 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:18 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:18 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:18 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:18 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:18 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreStateMachine::startPlaybackTimer Mar 11 13:15:18 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:18 dar-1000es volumio[728]: info: [1741695318200] ControllerWebradio::clearAddPlayTrack Mar 11 13:15:18 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:18 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:18 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:18 dar-1000es volumio[728]: info: sendMpdCommand stop took 11 milliseconds Mar 11 13:15:18 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand clear Mar 11 13:15:18 dar-1000es volumio[728]: info: Mar 11 13:15:18 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:18 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:18 dar-1000es volumio[728]: info: sendMpdCommand clear took 1 milliseconds Mar 11 13:15:18 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand load "http://mediaserv33.live-streams.nl:8036" Mar 11 13:15:19 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:19 dar-1000es volumio[728]: info: ------------------------------ 1209ms Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" Mar 11 13:15:19 dar-1000es volumio[728]: info: Mar 11 13:15:19 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:19 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:19 dar-1000es volumio[728]: info: sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" took 1 milliseconds Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand play Mar 11 13:15:19 dar-1000es volumio[728]: info: ------------------------------ 1ms Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:19 dar-1000es volumio[728]: info: sendMpdCommand play took 3 milliseconds Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:19 dar-1000es volumio[728]: info: Mar 11 13:15:19 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:19 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:19 dar-1000es kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 11 13:15:19 dar-1000es volumio[728]: info: Mar 11 13:15:19 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:19 dar-1000es volumio[728]: info: sendMpdCommand status took 63 milliseconds Mar 11 13:15:19 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:19 dar-1000es volumio[728]: info: sendMpdCommand status took 2 milliseconds Mar 11 13:15:19 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:19 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:19 dar-1000es volumio[728]: 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":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Mar 11 13:15:19 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:19 dar-1000es volumio[728]: info: ------------------------------ 83ms Mar 11 13:15:19 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 11 13:15:19 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:19 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:19 dar-1000es volumio[728]: 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":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Mar 11 13:15:19 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:19 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:19 dar-1000es volumio[728]: info: ------------------------------ 43ms Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:19 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:19 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:19 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:19 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:19 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: Mar 11 13:15:20 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:20 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:20 dar-1000es volumio[728]: info: Mar 11 13:15:20 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:20 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:20 dar-1000es volumio[728]: info: Mar 11 13:15:20 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:20 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:20 dar-1000es volumio[728]: info: Mar 11 13:15:20 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:20 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:20 dar-1000es volumio[728]: info: ------------------------------ 10ms Mar 11 13:15:20 dar-1000es volumio[728]: info: sendMpdCommand status took 6 milliseconds Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:20 dar-1000es volumio[728]: info: ------------------------------ 12ms Mar 11 13:15:20 dar-1000es volumio[728]: info: sendMpdCommand status took 8 milliseconds Mar 11 13:15:20 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:20 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:20 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cosmic Gate - Seize of the Day","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Mar 11 13:15:20 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:20 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:20 dar-1000es volumio[728]: info: ------------------------------ 48ms Mar 11 13:15:20 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 32 milliseconds Mar 11 13:15:20 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:20 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:20 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Cosmic Gate - Seize of the Day","artist":"Hi On Line Lounge Radio","album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Mar 11 13:15:20 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:20 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:20 dar-1000es volumio[728]: info: ------------------------------ 77ms Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:20 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:20 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:20 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:20 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:21 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:22 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:23 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:24 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:25 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:26 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:27 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:28 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:29 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:30 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:31 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:32 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:33 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:34 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:35 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:36 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:37 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:38 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::stPlaybackTimer Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::serviceStop Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::serviceStop Mar 11 13:15:38 dar-1000es volumio[728]: info: [1741695338607] ControllerWebradio::stop Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::addQueueItems Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::addQueueItems Mar 11 13:15:38 dar-1000es volumio[728]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1916740 Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:38 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:38 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::startPlaybackTimer Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:38 dar-1000es volumio[728]: info: [1741695338628] ControllerWebradio::clearAddPlayTrack Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:38 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:38 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:38 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:38 dar-1000es volumio[728]: info: Mar 11 13:15:38 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:38 dar-1000es volumio[728]: info: sendMpdCommand stop took 101 milliseconds Mar 11 13:15:38 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:38 dar-1000es volumio[728]: info: sendMpdCommand stop took 80 milliseconds Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand clear Mar 11 13:15:38 dar-1000es volumio[728]: info: Mar 11 13:15:38 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:38 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:38 dar-1000es volumio[728]: info: sendMpdCommand status took 4 milliseconds Mar 11 13:15:38 dar-1000es volumio[728]: info: sendMpdCommand clear took 4 milliseconds Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1916740" Mar 11 13:15:38 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:38 dar-1000es volumio[728]: info: ------------------------------ 7ms Mar 11 13:15:38 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:38 dar-1000es volumio[728]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 11 13:15:38 dar-1000es volumio[728]: info: ------------------------------ 11ms Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:38 dar-1000es volumio[728]: info: Mar 11 13:15:38 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:38 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:38 dar-1000es volumio[728]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1916740" took 122 milliseconds Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 11 13:15:38 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand play Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: ------------------------------ 59ms Mar 11 13:15:38 dar-1000es volumio[728]: info: sendMpdCommand play took 60 milliseconds Mar 11 13:15:38 dar-1000es volumio[728]: info: touch_display: Using Xserver unix domain socket /tmp/.X11-unix/X0 Mar 11 13:15:38 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:38 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:39 dar-1000es volumio[728]: info: Mar 11 13:15:39 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:39 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:39 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:39 dar-1000es kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 11 13:15:40 dar-1000es volumio[728]: info: Mar 11 13:15:40 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:40 dar-1000es volumio[728]: info: sendMpdCommand status took 68 milliseconds Mar 11 13:15:40 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:40 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:40 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:40 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:40 dar-1000es volumio[728]: info: Mar 11 13:15:40 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:40 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:40 dar-1000es volumio[728]: info: sendMpdCommand status took 5 milliseconds Mar 11 13:15:40 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 5 milliseconds Mar 11 13:15:40 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:40 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:40 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:40 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:40 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"245 Kbps","isStreaming":false,"title":"Music Freeze Your Mind","artist":"COOLfahrenheit","album":null,"uri":"http://103.253.135.4:5014","trackType":"4:5014"} Mar 11 13:15:40 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:40 dar-1000es volumio[728]: info: ------------------------------ 87ms Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: ------------------------------ 18ms Mar 11 13:15:40 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 14 milliseconds Mar 11 13:15:40 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:40 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:40 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"245 Kbps","isStreaming":false,"title":"Music Freeze Your Mind","artist":"COOLfahrenheit","album":null,"uri":"http://103.253.135.4:5014","trackType":"4:5014"} Mar 11 13:15:40 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:40 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:40 dar-1000es volumio[728]: info: ------------------------------ 39ms Mar 11 13:15:40 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:40 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:40 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 11 13:15:40 dar-1000es volumio[728]: info: Discovery: Getting this device information Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:40 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:41 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:42 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:43 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:44 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:45 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::stPlaybackTimer Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::serviceStop Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::serviceStop Mar 11 13:15:45 dar-1000es volumio[728]: info: [1741695345231] ControllerWebradio::stop Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::addQueueItems Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::addQueueItems Mar 11 13:15:45 dar-1000es volumio[728]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1778139 Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:45 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:45 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::startPlaybackTimer Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:45 dar-1000es volumio[728]: info: [1741695345249] ControllerWebradio::clearAddPlayTrack Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:45 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:45 dar-1000es volumio[728]: info: Mar 11 13:15:45 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:45 dar-1000es volumio[728]: info: sendMpdCommand stop took 101 milliseconds Mar 11 13:15:45 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:45 dar-1000es volumio[728]: info: sendMpdCommand stop took 84 milliseconds Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand clear Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:45 dar-1000es volumio[728]: info: Mar 11 13:15:45 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:45 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:45 dar-1000es volumio[728]: info: sendMpdCommand status took 12 milliseconds Mar 11 13:15:45 dar-1000es volumio[728]: info: sendMpdCommand clear took 12 milliseconds Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1778139" Mar 11 13:15:45 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:45 dar-1000es volumio[728]: info: ------------------------------ 5ms Mar 11 13:15:45 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:45 dar-1000es volumio[728]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 11 13:15:45 dar-1000es volumio[728]: info: ------------------------------ 18ms Mar 11 13:15:45 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:45 dar-1000es volumio[728]: info: Mar 11 13:15:45 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:45 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:45 dar-1000es volumio[728]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1778139" took 117 milliseconds Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 11 13:15:45 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand play Mar 11 13:15:45 dar-1000es volumio[728]: info: ------------------------------ 4ms Mar 11 13:15:45 dar-1000es volumio[728]: info: sendMpdCommand play took 3 milliseconds Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:45 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 11 13:15:46 dar-1000es volumio[728]: info: Mar 11 13:15:46 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:46 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:46 dar-1000es volumio[728]: info: Mar 11 13:15:46 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:46 dar-1000es volumio[728]: info: sendMpdCommand status took 67 milliseconds Mar 11 13:15:46 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:46 dar-1000es volumio[728]: info: Mar 11 13:15:46 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:46 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:46 dar-1000es volumio[728]: info: Mar 11 13:15:46 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:46 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:46 dar-1000es volumio[728]: info: sendMpdCommand status took 3 milliseconds Mar 11 13:15:46 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:46 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:46 dar-1000es volumio[728]: 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":"192 Kbps","isStreaming":false,"title":"Frank Borell - Somber Moods","artist":"1.FM - Chillout Lounge Radio","album":null,"uri":"http://185.33.21.112:80/chilloutlounge_128","trackType":""} Mar 11 13:15:46 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:46 dar-1000es volumio[728]: info: ------------------------------ 81ms Mar 11 13:15:46 dar-1000es volumio[728]: info: ------------------------------ 14ms Mar 11 13:15:46 dar-1000es volumio[728]: info: sendMpdCommand status took 14 milliseconds Mar 11 13:15:46 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 13 milliseconds Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:46 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:46 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Frank Borell - Somber Moods","artist":"1.FM - Chillout Lounge Radio","album":null,"uri":"http://185.33.21.112:80/chilloutlounge_128","trackType":""} Mar 11 13:15:46 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:46 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:46 dar-1000es volumio[728]: info: ------------------------------ 39ms Mar 11 13:15:46 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:46 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:46 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:46 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 124 milliseconds Mar 11 13:15:46 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:46 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:46 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":724,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Frank Borell - Somber Moods","artist":"1.FM - Chillout Lounge Radio","album":null,"uri":"http://185.33.21.112:80/chilloutlounge_128","trackType":""} Mar 11 13:15:46 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:46 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:46 dar-1000es volumio[728]: info: ------------------------------ 168ms Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:46 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:46 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:46 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:47 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:48 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:49 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:50 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:51 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:52 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:53 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:54 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::stPlaybackTimer Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::serviceStop Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::serviceStop Mar 11 13:15:55 dar-1000es volumio[728]: info: [1741695355279] ControllerWebradio::stop Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::addQueueItems Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::addQueueItems Mar 11 13:15:55 dar-1000es volumio[728]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s297682 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 11 13:15:55 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:55 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:55 dar-1000es volumio[728]: info: Mar 11 13:15:55 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:55 dar-1000es volumio[728]: info: sendMpdCommand stop took 124 milliseconds Mar 11 13:15:55 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioClearQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: sendMpdCommand status took 35 milliseconds Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:55 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:55 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:55 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 33 milliseconds Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:55 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Frank Borell - Somber Moods","artist":"1.FM - Chillout Lounge Radio","album":null,"uri":"http://185.33.21.112:80/chilloutlounge_128","trackType":""} Mar 11 13:15:55 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService stop Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:55 dar-1000es volumio[728]: info: No code Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:55 dar-1000es volumio[728]: info: ------------------------------ 116ms Mar 11 13:15:55 dar-1000es volumio[728]: info: Mar 11 13:15:55 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:55 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:55 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:55 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:55 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:55 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:55 dar-1000es volumio[728]: info: ------------------------------ 36ms Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:55 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:15:55 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::startPlaybackTimer Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: [1741695355796] ControllerWebradio::clearAddPlayTrack Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:15:55 dar-1000es volumio[728]: info: sendMpdCommand stop took 4 milliseconds Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand clear Mar 11 13:15:55 dar-1000es volumio[728]: info: Mar 11 13:15:55 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:55 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:55 dar-1000es volumio[728]: info: sendMpdCommand clear took 4 milliseconds Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand load "https://radio.jump.bg/stream/georgi18/stream.pls" Mar 11 13:15:55 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:15:55 dar-1000es volumio[728]: info: ------------------------------ 5ms Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:55 dar-1000es volumio[728]: info: Mar 11 13:15:55 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:55 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:55 dar-1000es volumio[728]: info: sendMpdCommand load "https://radio.jump.bg/stream/georgi18/stream.pls" took 184 milliseconds Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 11 13:15:55 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand play Mar 11 13:15:55 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:55 dar-1000es volumio[728]: info: ------------------------------ 5ms Mar 11 13:15:55 dar-1000es volumio[728]: info: sendMpdCommand play took 3 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 11 13:15:56 dar-1000es volumio[728]: info: Mar 11 13:15:56 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:56 dar-1000es volumio[728]: info: Mar 11 13:15:56 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand status took 61 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand status took 1 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:56 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://radio.jump.bg/proxy/georgi18/stream","trackType":""} Mar 11 13:15:56 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:56 dar-1000es volumio[728]: info: ------------------------------ 69ms Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:56 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":null,"album":null,"uri":"https://radio.jump.bg/proxy/georgi18/stream","trackType":""} Mar 11 13:15:56 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:56 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:56 dar-1000es volumio[728]: info: ------------------------------ 38ms Mar 11 13:15:56 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:56 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:56 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:56 dar-1000es volumio[728]: info: Mar 11 13:15:56 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:56 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:56 dar-1000es volumio[728]: info: Mar 11 13:15:56 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es volumio[728]: info: Mar 11 13:15:56 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:15:56 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:15:56 dar-1000es volumio[728]: info: Mar 11 13:15:56 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:15:56 dar-1000es volumio[728]: info: ------------------------------ 52ms Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand status took 38 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:56 dar-1000es volumio[728]: info: ------------------------------ 16ms Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand status took 15 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:56 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Regard Years Years - Hallucination [4iZt]","artist":"Deep Radio Europe","album":null,"uri":"https://radio.jump.bg/proxy/georgi18/stream","trackType":""} Mar 11 13:15:56 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:56 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:56 dar-1000es volumio[728]: info: ------------------------------ 88ms Mar 11 13:15:56 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:15:56 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 24 milliseconds Mar 11 13:15:56 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:15:56 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:15:56 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"160 Kbps","isStreaming":false,"title":"Regard Years Years - Hallucination [4iZt]","artist":"Deep Radio Europe","album":null,"uri":"https://radio.jump.bg/proxy/georgi18/stream","trackType":""} Mar 11 13:15:56 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:15:56 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:15:56 dar-1000es volumio[728]: info: ------------------------------ 69ms Mar 11 13:15:56 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:56 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:56 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:56 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:56 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:57 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:58 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:15:59 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:00 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::stPlaybackTimer Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::serviceStop Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::serviceStop Mar 11 13:16:00 dar-1000es volumio[728]: info: [1741695360066] ControllerWebradio::stop Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::addQueueItems Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::addQueueItems Mar 11 13:16:00 dar-1000es volumio[728]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1916740 Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:16:00 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:00 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::startPlaybackTimer Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:00 dar-1000es volumio[728]: info: [1741695360106] ControllerWebradio::clearAddPlayTrack Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:16:00 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:00 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:00 dar-1000es volumio[728]: info: Mar 11 13:16:00 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:16:00 dar-1000es volumio[728]: info: sendMpdCommand stop took 75 milliseconds Mar 11 13:16:00 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:16:00 dar-1000es volumio[728]: info: sendMpdCommand stop took 36 milliseconds Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand clear Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:00 dar-1000es volumio[728]: info: Mar 11 13:16:00 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:16:00 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:16:00 dar-1000es volumio[728]: info: sendMpdCommand status took 47 milliseconds Mar 11 13:16:00 dar-1000es volumio[728]: info: sendMpdCommand clear took 41 milliseconds Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1916740" Mar 11 13:16:00 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:16:00 dar-1000es volumio[728]: info: ------------------------------ 13ms Mar 11 13:16:00 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 15 milliseconds Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:16:00 dar-1000es volumio[728]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 11 13:16:00 dar-1000es volumio[728]: info: ------------------------------ 75ms Mar 11 13:16:00 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:16:00 dar-1000es volumio[728]: info: Mar 11 13:16:00 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:16:00 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:16:00 dar-1000es volumio[728]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1916740" took 122 milliseconds Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 11 13:16:00 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand play Mar 11 13:16:00 dar-1000es volumio[728]: info: ------------------------------ 9ms Mar 11 13:16:00 dar-1000es volumio[728]: info: sendMpdCommand play took 2 milliseconds Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:00 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: Mar 11 13:16:01 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:16:01 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:16:01 dar-1000es kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 11 13:16:01 dar-1000es volumio[728]: info: Mar 11 13:16:01 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:16:01 dar-1000es volumio[728]: info: sendMpdCommand status took 71 milliseconds Mar 11 13:16:01 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:16:01 dar-1000es volumio[728]: info: Mar 11 13:16:01 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:16:01 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:16:01 dar-1000es volumio[728]: info: sendMpdCommand status took 2 milliseconds Mar 11 13:16:01 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:16:01 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:01 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"Music Freeze Your Mind","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.135.4:5014","trackType":"4:5014"} Mar 11 13:16:01 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:01 dar-1000es volumio[728]: info: ------------------------------ 91ms Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: ------------------------------ 33ms Mar 11 13:16:01 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 25 milliseconds Mar 11 13:16:01 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:16:01 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:01 dar-1000es volumio[728]: verbose: STATE SERVICE {"status":"play","position":0,"seek":731,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"255 Kbps","isStreaming":false,"title":"Music Freeze Your Mind","artist":"COOLfahrenheit | Easy Listening","album":null,"uri":"http://103.253.135.4:5014","trackType":"4:5014"} Mar 11 13:16:01 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:16:01 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:01 dar-1000es volumio[728]: info: ------------------------------ 84ms Mar 11 13:16:01 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:01 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:01 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:01 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:02 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:03 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:04 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:05 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:06 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:07 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::stPlaybackTimer Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::serviceStop Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::serviceStop Mar 11 13:16:08 dar-1000es volumio[728]: info: [1741695368659] ControllerWebradio::stop Mar 11 13:16:08 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::addQueueItems Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::addQueueItems Mar 11 13:16:08 dar-1000es volumio[728]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s223154 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::updateTrackBlock Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrackBlock Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:16:08 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::startPlaybackTimer Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: [1741695368705] ControllerWebradio::clearAddPlayTrack Mar 11 13:16:08 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand stop Mar 11 13:16:08 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:08 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioClearQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::ClearQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::clearPlayQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::saveQueue Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushQueue Mar 11 13:16:08 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:08 dar-1000es volumio[728]: info: Mar 11 13:16:08 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:16:08 dar-1000es volumio[728]: info: Mar 11 13:16:08 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:16:08 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:16:08 dar-1000es volumio[728]: info: sendMpdCommand stop took 131 milliseconds Mar 11 13:16:08 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:16:08 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:16:08 dar-1000es volumio[728]: info: sendMpdCommand stop took 85 milliseconds Mar 11 13:16:08 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand clear Mar 11 13:16:08 dar-1000es volumio[728]: info: touch_display: Setting screensaver timeout to 0 seconds. Mar 11 13:16:08 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:16:08 dar-1000es volumio[728]: info: Mar 11 13:16:08 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:16:08 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:16:08 dar-1000es volumio[728]: info: sendMpdCommand status took 4 milliseconds Mar 11 13:16:08 dar-1000es volumio[728]: info: ------------------------------ 5ms Mar 11 13:16:08 dar-1000es volumio[728]: info: sendMpdCommand clear took 4 milliseconds Mar 11 13:16:08 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:16:08 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand load "http://mediaserv33.live-streams.nl:8036" Mar 11 13:16:08 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: 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} Mar 11 13:16:08 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService stop Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:08 dar-1000es volumio[728]: info: No code Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:08 dar-1000es volumio[728]: info: ------------------------------ 43ms Mar 11 13:16:08 dar-1000es volumio[728]: error: updateQueue error: null Mar 11 13:16:08 dar-1000es volumio[728]: info: ------------------------------ 43ms Mar 11 13:16:08 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:08 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:08 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPlay Mar 11 13:16:08 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::play index 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::stop Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: verbose: UNSET VOLATILE Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::play index undefined Mar 11 13:16:08 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 11 13:16:08 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:09 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:09 dar-1000es volumio[728]: info: Mar 11 13:16:09 dar-1000es volumio[728]: ---------------------------- MPD announces system playlist update Mar 11 13:16:09 dar-1000es volumio[728]: info: Ignoring MPD Status Update Mar 11 13:16:09 dar-1000es volumio[728]: info: sendMpdCommand add "http://mediaserv33.live-streams.nl:8036" took 7 milliseconds Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand play Mar 11 13:16:09 dar-1000es volumio[728]: info: ------------------------------ 2ms Mar 11 13:16:09 dar-1000es volumio[728]: info: sendMpdCommand play took 1 milliseconds Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:09 dar-1000es volumio[728]: info: Mar 11 13:16:09 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:16:09 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:16:09 dar-1000es kernel: pcm512x 1-004c: No SCLK, using BCLK: -2 Mar 11 13:16:09 dar-1000es volumio[728]: info: sendMpdCommand status took 62 milliseconds Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:16:09 dar-1000es volumio[728]: info: Mar 11 13:16:09 dar-1000es volumio[728]: ---------------------------- MPD announces state update: player Mar 11 13:16:09 dar-1000es volumio[728]: info: ControllerMpd::getState Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand status Mar 11 13:16:09 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:16:09 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:16:09 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:09 dar-1000es volumio[728]: 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":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Mar 11 13:16:09 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus stop Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioPushState Mar 11 13:16:09 dar-1000es volumio[728]: info: ------------------------------ 78ms Mar 11 13:16:09 dar-1000es volumio[728]: info: sendMpdCommand status took 14 milliseconds Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::parseState Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:09 dar-1000es volumio[728]: SPOTIFY: RECEIVED VOLUMIO VOLUME 79 Mar 11 13:16:09 dar-1000es volumio[728]: info: sendMpdCommand playlistinfo took 43 milliseconds Mar 11 13:16:09 dar-1000es volumio[728]: verbose: ControllerMpd::parseTrackInfo Mar 11 13:16:09 dar-1000es volumio[728]: info: ControllerMpd::pushState Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::servicePushState Mar 11 13:16:09 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:09 dar-1000es volumio[728]: 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":"mediaserv33.live-streams.nl:8036","artist":null,"album":null,"uri":"http://mediaserv33.live-streams.nl:8036","trackType":"nl:8036"} Mar 11 13:16:09 dar-1000es volumio[728]: verbose: CURRENT POSITION 0 Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreStateMachine::syncState stateService play Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreStateMachine::syncState currentStatus play Mar 11 13:16:09 dar-1000es volumio[728]: info: Received an update from plugin. extracting info from payload Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreStateMachine::pushState Mar 11 13:16:09 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:09 dar-1000es volumio[728]: error: ControllerMpd::pushError: TypeError: Cannot read property 'name' of undefined Mar 11 13:16:09 dar-1000es volumio[728]: info: ------------------------------ 65ms Mar 11 13:16:09 dar-1000es volumio[728]: info: CoreCommandRouter::volumioGetState Mar 11 13:16:09 dar-1000es volumio[728]: info: CorePlayQueue::getTrack 0 Mar 11 13:16:09 dar-1000es volumio[728]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 11 13:16:09 dar-1000es volumio[728]: TypeError: Cannot read property 'name' of undefined Mar 11 13:16:09 dar-1000es volumio[728]: at CoreStateMachine.getState (/volumio/app/statemachine.js:122:48) Mar 11 13:16:09 dar-1000es volumio[728]: at CoreCommandRouter.volumioGetState (/volumio/app/index.js:104:28) Mar 11 13:16:09 dar-1000es volumio[728]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:50:38) Mar 11 13:16:09 dar-1000es volumio[728]: at Socket.emit (events.js:315:20) Mar 11 13:16:09 dar-1000es volumio[728]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Mar 11 13:16:09 dar-1000es volumio[728]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 11 13:16:09 dar-1000es volumio[728]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 11 13:16:10 dar-1000es sudo[1950]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-11 13:15 Mar 11 13:16:10 dar-1000es sudo[1950]: 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="1f061e035f7cb2799b32d3520aa8e55cd07df6f9" VOLUMIO_FE_VERSION="9971a09df9c3edfdedf2ecf438999be8aba9db68" VOLUMIO_FE3_VERSION="3974def988c7b2392ddc85f9b8cb4692d5e8fda9" VOLUMIO_BE_VERSION="b3c53a818b9b3d0e5c13c9d346c4d613c4ca426f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 11 Jul 2022 04:03:33 PM CEST" VOLUMIO_VERSION="3.324" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5b2f59e6e90e57f326ca25c7ca839d52"