-- Logs begin at Thu 2024-07-25 08:36:43 CEST, end at Fri 2024-07-26 06:01:58 CEST. -- Jul 26 06:00:06 volumiograf volumio[908]: info: CoreCommandRouter::volumioPlay Jul 26 06:00:06 volumiograf volumio[908]: info: CoreStateMachine::play index undefined Jul 26 06:00:06 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:06 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:06 volumiograf volumio[908]: info: CoreStateMachine::startPlaybackTimer Jul 26 06:00:06 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:06 volumiograf volumio[908]: info: [1721966406130] ControllerWebradio::clearAddPlayTrack Jul 26 06:00:06 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 06:00:06 volumiograf volumio[908]: info: sendMpdCommand stop took 1 milliseconds Jul 26 06:00:06 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 06:00:06 volumiograf volumio[908]: info: sendMpdCommand clear took 1 milliseconds Jul 26 06:00:06 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" Jul 26 06:00:06 volumiograf volumio[908]: info: Jul 26 06:00:06 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:06 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:06 volumiograf volumio[908]: info: Jul 26 06:00:06 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:06 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:06 volumiograf volumio[908]: info: Jul 26 06:00:06 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:06 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:06 volumiograf volumio[908]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" took 100 milliseconds Jul 26 06:00:06 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 26 06:00:06 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand play Jul 26 06:00:06 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:06 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:06 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:06 volumiograf volumio[908]: info: ------------------------------ 102ms Jul 26 06:00:06 volumiograf volumio[908]: info: ------------------------------ 99ms Jul 26 06:00:06 volumiograf volumio[908]: info: ------------------------------ 98ms Jul 26 06:00:06 volumiograf volumio[908]: info: sendMpdCommand play took 4 milliseconds Jul 26 06:00:07 volumiograf kernel: hwmon hwmon1: Undervoltage detected! Jul 26 06:00:09 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:09 volumiograf volumio[908]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::ClearQueue Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:09 volumiograf volumio[908]: info: CorePlayQueue::clearPlayQueue Jul 26 06:00:09 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:09 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::addQueueItems Jul 26 06:00:09 volumiograf volumio[908]: info: CorePlayQueue::addQueueItems Jul 26 06:00:09 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:09 volumiograf volumio[908]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315 Jul 26 06:00:09 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 26 06:00:09 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:09 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::updateTrackBlock Jul 26 06:00:09 volumiograf volumio[908]: info: CorePlayQueue::getTrackBlock Jul 26 06:00:09 volumiograf volumio[908]: info: CoreCommandRouter::volumioPlay Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::play index 0 Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::play index undefined Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:09 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::startPlaybackTimer Jul 26 06:00:09 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:09 volumiograf volumio[908]: info: [1721966409864] ControllerWebradio::clearAddPlayTrack Jul 26 06:00:09 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 06:00:09 volumiograf volumio[908]: info: sendMpdCommand stop took 3 milliseconds Jul 26 06:00:09 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 06:00:09 volumiograf volumio[908]: info: sendMpdCommand clear took 1 milliseconds Jul 26 06:00:09 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" Jul 26 06:00:09 volumiograf volumio[908]: info: Jul 26 06:00:09 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:09 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:09 volumiograf volumio[908]: info: Jul 26 06:00:09 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:09 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:09 volumiograf volumio[908]: info: Jul 26 06:00:09 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:09 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:09 volumiograf volumio[908]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" took 102 milliseconds Jul 26 06:00:09 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 26 06:00:09 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand play Jul 26 06:00:09 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:09 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:09 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:09 volumiograf volumio[908]: info: ------------------------------ 105ms Jul 26 06:00:09 volumiograf volumio[908]: info: ------------------------------ 103ms Jul 26 06:00:09 volumiograf volumio[908]: info: ------------------------------ 102ms Jul 26 06:00:09 volumiograf volumio[908]: info: sendMpdCommand play took 5 milliseconds Jul 26 06:00:15 volumiograf volumio[908]: info: CoreCommandRouter::volumioPlay Jul 26 06:00:15 volumiograf volumio[908]: info: CoreStateMachine::play index undefined Jul 26 06:00:15 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:15 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:15 volumiograf volumio[908]: info: CoreStateMachine::startPlaybackTimer Jul 26 06:00:15 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:15 volumiograf volumio[908]: info: [1721966415319] ControllerWebradio::clearAddPlayTrack Jul 26 06:00:15 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 06:00:15 volumiograf volumio[908]: info: sendMpdCommand stop took 1 milliseconds Jul 26 06:00:15 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 06:00:15 volumiograf volumio[908]: info: sendMpdCommand clear took 1 milliseconds Jul 26 06:00:15 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" Jul 26 06:00:15 volumiograf volumio[908]: info: Jul 26 06:00:15 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:15 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:15 volumiograf volumio[908]: info: Jul 26 06:00:15 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:15 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:15 volumiograf volumio[908]: info: Jul 26 06:00:15 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:15 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:15 volumiograf kernel: hwmon hwmon1: Voltage normalised Jul 26 06:00:15 volumiograf volumio[908]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" took 101 milliseconds Jul 26 06:00:15 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 26 06:00:15 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand play Jul 26 06:00:15 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:15 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:15 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:15 volumiograf volumio[908]: info: ------------------------------ 104ms Jul 26 06:00:15 volumiograf volumio[908]: info: ------------------------------ 101ms Jul 26 06:00:15 volumiograf volumio[908]: info: ------------------------------ 101ms Jul 26 06:00:15 volumiograf volumio[908]: info: sendMpdCommand play took 3 milliseconds Jul 26 06:00:17 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:17 volumiograf volumio[908]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::ClearQueue Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:17 volumiograf volumio[908]: info: CorePlayQueue::clearPlayQueue Jul 26 06:00:17 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:17 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::addQueueItems Jul 26 06:00:17 volumiograf volumio[908]: info: CorePlayQueue::addQueueItems Jul 26 06:00:17 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:17 volumiograf volumio[908]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s260580 Jul 26 06:00:17 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 26 06:00:17 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:17 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::updateTrackBlock Jul 26 06:00:17 volumiograf volumio[908]: info: CorePlayQueue::getTrackBlock Jul 26 06:00:17 volumiograf volumio[908]: info: CoreCommandRouter::volumioPlay Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::play index 0 Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::play index undefined Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:17 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:17 volumiograf volumio[908]: info: CoreStateMachine::startPlaybackTimer Jul 26 06:00:17 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:17 volumiograf volumio[908]: info: [1721966417395] ControllerWebradio::clearAddPlayTrack Jul 26 06:00:17 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 06:00:17 volumiograf volumio[908]: info: sendMpdCommand stop took 5 milliseconds Jul 26 06:00:17 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 06:00:17 volumiograf volumio[908]: info: sendMpdCommand clear took 1 milliseconds Jul 26 06:00:17 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand load "https://radio.streemlion.com:3590/stream" Jul 26 06:00:17 volumiograf volumio[908]: info: Jul 26 06:00:17 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:17 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:17 volumiograf volumio[908]: info: Jul 26 06:00:17 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:17 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:17 volumiograf volumio[908]: info: Jul 26 06:00:17 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:17 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:19 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand add "https://radio.streemlion.com:3590/stream" Jul 26 06:00:19 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:19 volumiograf volumio[908]: info: Jul 26 06:00:19 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:19 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:19 volumiograf volumio[908]: info: ------------------------------ 1809ms Jul 26 06:00:19 volumiograf volumio[908]: info: ------------------------------ 1807ms Jul 26 06:00:19 volumiograf volumio[908]: info: ------------------------------ 1806ms Jul 26 06:00:19 volumiograf volumio[908]: info: sendMpdCommand add "https://radio.streemlion.com:3590/stream" took 5 milliseconds Jul 26 06:00:19 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 26 06:00:19 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand play Jul 26 06:00:19 volumiograf volumio[908]: info: Jul 26 06:00:19 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:19 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:19 volumiograf volumio[908]: info: Jul 26 06:00:19 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:19 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:19 volumiograf volumio[908]: info: ------------------------------ 12ms Jul 26 06:00:19 volumiograf volumio[908]: info: sendMpdCommand play took 10 milliseconds Jul 26 06:00:19 volumiograf volumio[908]: info: ------------------------------ 8ms Jul 26 06:00:19 volumiograf volumio[908]: info: ------------------------------ 5ms Jul 26 06:00:19 volumiograf kernel: hwmon hwmon1: Undervoltage detected! Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand status took 25 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand status took 44 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand status took 43 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 23 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: 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.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:21 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus stop Jul 26 06:00:21 volumiograf volumio[908]: info: ------------------------------ 62ms Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand status took 25 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand status took 23 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand status took 19 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:21 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:21 volumiograf volumio[908]: info: Jul 26 06:00:21 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 28 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 13 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 12 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 12 milliseconds Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:21 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: 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.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:21 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:21 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: 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.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:21 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:21 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: 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":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:21 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:21 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: 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":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:21 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:21 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: 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":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:21 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:21 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:21 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 197ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 196ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 167ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 165ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 163ms Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:22 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:22 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:22 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 144ms Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand status took 140 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 15ms Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand status took 13 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 12ms Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:22 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:22 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:22 volumiograf volumio[908]: info: Jul 26 06:00:22 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand status took 56 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 55ms Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand status took 50 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 47 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 46 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 45ms Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand status took 43 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 42ms Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand status took 40 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:22 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:22 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Deckspace - Funki Porcini","artist":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:22 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:22 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:22 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:22 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Deckspace - Funki Porcini","artist":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:22 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:22 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 245ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 117ms Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 54 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 54 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 55 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 55 milliseconds Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:22 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:22 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:22 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Deckspace - Funki Porcini","artist":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:22 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:22 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:22 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:22 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Deckspace - Funki Porcini","artist":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:22 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:22 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:22 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:22 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Deckspace - Funki Porcini","artist":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:22 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:22 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:22 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:22 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":982,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"Deckspace - Funki Porcini","artist":"Nordic Lodge Copenhagen","album":null,"uri":"https://radio.streemlion.com:3590/stream","trackType":""} Jul 26 06:00:22 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:22 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:22 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 205ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 201ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 192ms Jul 26 06:00:22 volumiograf volumio[908]: info: ------------------------------ 190ms Jul 26 06:00:32 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::ClearQueue Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::stPlaybackTimer Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::updateTrackBlock Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrackBlock Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::serviceStop Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::serviceStop Jul 26 06:00:32 volumiograf volumio[908]: info: [1721966432832] ControllerWebradio::stop Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::clearPlayQueue Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::addQueueItems Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::addQueueItems Jul 26 06:00:32 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:32 volumiograf volumio[908]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315 Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::updateTrackBlock Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrackBlock Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::volumioPlay Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::play index 0 Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::play index undefined Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::startPlaybackTimer Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: [1721966432864] ControllerWebradio::clearAddPlayTrack Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 06:00:32 volumiograf volumio[908]: info: Jul 26 06:00:32 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:32 volumiograf volumio[908]: info: sendMpdCommand stop took 49 milliseconds Jul 26 06:00:32 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:32 volumiograf volumio[908]: info: sendMpdCommand stop took 18 milliseconds Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 06:00:32 volumiograf volumio[908]: info: Jul 26 06:00:32 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:32 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:32 volumiograf volumio[908]: info: Jul 26 06:00:32 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:32 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:32 volumiograf volumio[908]: info: Jul 26 06:00:32 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:32 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:32 volumiograf volumio[908]: info: sendMpdCommand status took 16 milliseconds Jul 26 06:00:32 volumiograf volumio[908]: info: sendMpdCommand clear took 14 milliseconds Jul 26 06:00:32 volumiograf volumio[908]: info: sendMpdCommand status took 10 milliseconds Jul 26 06:00:32 volumiograf volumio[908]: info: sendMpdCommand status took 8 milliseconds Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:32 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 26 06:00:32 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:32 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:32 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:32 volumiograf volumio[908]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jul 26 06:00:32 volumiograf volumio[908]: info: ------------------------------ 80ms Jul 26 06:00:32 volumiograf volumio[908]: info: ------------------------------ 79ms Jul 26 06:00:32 volumiograf volumio[908]: info: Jul 26 06:00:32 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:32 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:32 volumiograf volumio[908]: info: Jul 26 06:00:32 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:32 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:32 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:32 volumiograf volumio[908]: info: ------------------------------ 92ms Jul 26 06:00:32 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 63 milliseconds Jul 26 06:00:32 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:32 volumiograf volumio[908]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jul 26 06:00:32 volumiograf volumio[908]: info: ------------------------------ 111ms Jul 26 06:00:33 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:33 volumiograf volumio[908]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99564315" took 113 milliseconds Jul 26 06:00:33 volumiograf volumio[908]: info: ------------------------------ 59ms Jul 26 06:00:33 volumiograf volumio[908]: info: ------------------------------ 58ms Jul 26 06:00:33 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 26 06:00:33 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand play Jul 26 06:00:33 volumiograf volumio[908]: info: sendMpdCommand play took 6 milliseconds Jul 26 06:00:40 volumiograf kernel: hwmon hwmon1: Voltage normalised Jul 26 06:00:42 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:42 volumiograf volumio[908]: info: CoreCommandRouter::volumioReplaceandPlayItems Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::ClearQueue Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:42 volumiograf volumio[908]: info: CorePlayQueue::clearPlayQueue Jul 26 06:00:42 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:42 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::addQueueItems Jul 26 06:00:42 volumiograf volumio[908]: info: CorePlayQueue::addQueueItems Jul 26 06:00:42 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:42 volumiograf volumio[908]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s326177 Jul 26 06:00:42 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jul 26 06:00:42 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushQueue Jul 26 06:00:42 volumiograf volumio[908]: info: CorePlayQueue::saveQueue Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::updateTrackBlock Jul 26 06:00:42 volumiograf volumio[908]: info: CorePlayQueue::getTrackBlock Jul 26 06:00:42 volumiograf volumio[908]: info: CoreCommandRouter::volumioPlay Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::play index 0 Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::stop Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::play index undefined Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService undefined Jul 26 06:00:42 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:42 volumiograf volumio[908]: info: CoreStateMachine::startPlaybackTimer Jul 26 06:00:42 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:42 volumiograf volumio[908]: info: [1721966442337] ControllerWebradio::clearAddPlayTrack Jul 26 06:00:42 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand stop Jul 26 06:00:42 volumiograf volumio[908]: info: sendMpdCommand stop took 4 milliseconds Jul 26 06:00:42 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand clear Jul 26 06:00:42 volumiograf volumio[908]: info: sendMpdCommand clear took 1 milliseconds Jul 26 06:00:42 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand load "http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 " Jul 26 06:00:42 volumiograf volumio[908]: info: Jul 26 06:00:42 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:42 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:42 volumiograf volumio[908]: info: Jul 26 06:00:42 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:42 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:42 volumiograf volumio[908]: info: Jul 26 06:00:42 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:42 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:44 volumiograf kernel: hwmon hwmon1: Undervoltage detected! Jul 26 06:00:45 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand add "http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 " Jul 26 06:00:45 volumiograf volumio[908]: error: updateQueue error: null Jul 26 06:00:45 volumiograf volumio[908]: info: Jul 26 06:00:45 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:45 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:45 volumiograf volumio[908]: info: ------------------------------ 2966ms Jul 26 06:00:45 volumiograf volumio[908]: info: ------------------------------ 2963ms Jul 26 06:00:45 volumiograf volumio[908]: info: ------------------------------ 2962ms Jul 26 06:00:45 volumiograf volumio[908]: info: sendMpdCommand add "http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 " took 6 milliseconds Jul 26 06:00:45 volumiograf volumio[908]: info: CoreStateMachine::setConsumeUpdateService mpd Jul 26 06:00:45 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand play Jul 26 06:00:45 volumiograf volumio[908]: Upnp client error: Error: This socket has been ended by the other party Jul 26 06:00:45 volumiograf volumio[908]: info: Jul 26 06:00:45 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:45 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:45 volumiograf volumio[908]: info: Jul 26 06:00:45 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:45 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:45 volumiograf volumio[908]: info: ------------------------------ 13ms Jul 26 06:00:45 volumiograf volumio[908]: info: sendMpdCommand play took 11 milliseconds Jul 26 06:00:45 volumiograf volumio[908]: info: ------------------------------ 6ms Jul 26 06:00:45 volumiograf volumio[908]: info: ------------------------------ 4ms Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand status took 27 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand status took 35 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand status took 33 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 10 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:46 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:46 volumiograf volumio[908]: 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.mp3 ","artist":null,"album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:46 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus stop Jul 26 06:00:46 volumiograf volumio[908]: info: ------------------------------ 51ms Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:46 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:46 volumiograf volumio[908]: info: Jul 26 06:00:46 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand status took 21 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 17 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 16 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand status took 11 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: info: sendMpdCommand status took 7 milliseconds Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:46 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:46 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:46 volumiograf volumio[908]: 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.mp3 ","artist":null,"album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:46 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:46 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:46 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:46 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:46 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:46 volumiograf volumio[908]: 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.mp3 ","artist":null,"album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:46 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:46 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:46 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:46 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:46 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 116ms Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 115ms Jul 26 06:00:47 volumiograf volumio[908]: info: Jul 26 06:00:47 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:47 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:47 volumiograf volumio[908]: info: Jul 26 06:00:47 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:47 volumiograf volumio[908]: info: Jul 26 06:00:47 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:47 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:47 volumiograf volumio[908]: info: Jul 26 06:00:47 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 74ms Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand status took 79 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 77 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 74 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 73 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 22ms Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand status took 20 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 19ms Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand status took 18 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:47 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:47 volumiograf volumio[908]: 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":"Chillout Radio","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:47 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:47 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:47 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:47 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":331,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Chillout Radio","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:47 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:47 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:47 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:47 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":742,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Chillout Radio","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:47 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:47 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 177ms Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 164ms Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 164ms Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 112 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 111 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 110 milliseconds Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:47 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:47 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:47 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Chillout Radio","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:47 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:47 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:47 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:47 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Chillout Radio","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:47 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:47 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:47 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:47 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"Chillout Radio","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:47 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:47 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 267ms Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 206ms Jul 26 06:00:47 volumiograf volumio[908]: info: ------------------------------ 205ms Jul 26 06:00:47 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 26 06:00:47 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:00:51 volumiograf volumio[908]: info: Jul 26 06:00:51 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:51 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:51 volumiograf volumio[908]: info: Jul 26 06:00:51 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:51 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:51 volumiograf volumio[908]: info: Jul 26 06:00:51 volumiograf volumio[908]: ---------------------------- MPD announces system playlist update Jul 26 06:00:51 volumiograf volumio[908]: info: Ignoring MPD Status Update Jul 26 06:00:51 volumiograf volumio[908]: info: Jul 26 06:00:51 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:51 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:51 volumiograf volumio[908]: info: Jul 26 06:00:51 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:51 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:51 volumiograf volumio[908]: info: Jul 26 06:00:51 volumiograf volumio[908]: ---------------------------- MPD announces state update: player Jul 26 06:00:51 volumiograf volumio[908]: info: ControllerMpd::getState Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand status Jul 26 06:00:51 volumiograf volumio[908]: info: ------------------------------ 21ms Jul 26 06:00:51 volumiograf volumio[908]: info: ------------------------------ 18ms Jul 26 06:00:51 volumiograf volumio[908]: info: ------------------------------ 16ms Jul 26 06:00:51 volumiograf volumio[908]: info: sendMpdCommand status took 12 milliseconds Jul 26 06:00:51 volumiograf volumio[908]: info: sendMpdCommand status took 8 milliseconds Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:51 volumiograf volumio[908]: info: sendMpdCommand status took 11 milliseconds Jul 26 06:00:51 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 26 06:00:51 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 6 milliseconds Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::parseState Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:51 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:51 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:51 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Cinematic Orchestra - Burn Out","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:51 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:51 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:51 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:51 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:51 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Cinematic Orchestra - Burn Out","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:51 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:51 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:51 volumiograf volumio[908]: info: ------------------------------ 65ms Jul 26 06:00:51 volumiograf volumio[908]: info: ------------------------------ 62ms Jul 26 06:00:51 volumiograf volumio[908]: info: sendMpdCommand playlistinfo took 43 milliseconds Jul 26 06:00:51 volumiograf volumio[908]: verbose: ControllerMpd::parseTrackInfo Jul 26 06:00:51 volumiograf volumio[908]: info: ControllerMpd::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::servicePushState Jul 26 06:00:51 volumiograf volumio[908]: info: CorePlayQueue::getTrack 0 Jul 26 06:00:51 volumiograf volumio[908]: verbose: STATE SERVICE {"status":"play","position":0,"seek":5577,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"320 Kbps","isStreaming":false,"title":"The Cinematic Orchestra - Burn Out","artist":"Chillout Radio","album":null,"uri":"http://channels.fluxfm.de/chillout-radio/tunein/stream.mp3 ","trackType":"mp3 "} Jul 26 06:00:51 volumiograf volumio[908]: verbose: CURRENT POSITION 0 Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::syncState stateService play Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::syncState currentStatus play Jul 26 06:00:51 volumiograf volumio[908]: info: Received an update from plugin. extracting info from payload Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreStateMachine::pushState Jul 26 06:00:51 volumiograf volumio[908]: info: CoreCommandRouter::volumioPushState Jul 26 06:00:51 volumiograf volumio[908]: info: ------------------------------ 82ms Jul 26 06:00:59 volumiograf volumio[908]: Searching all installed plugins Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: , search Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jul 26 06:00:59 volumiograf volumio[908]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 26 06:00:59 volumiograf volumio[908]: info: [ytmusic] InnertubeLoader: creating Innertube instance... Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Jul 26 06:00:59 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: spop , search Jul 26 06:01:01 volumiograf volumio[908]: Searching all installed plugins Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: , search Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jul 26 06:01:01 volumiograf volumio[908]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Jul 26 06:01:01 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: spop , search Jul 26 06:01:02 volumiograf volumio[908]: Searching all installed plugins Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: , search Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: last_100 , search Jul 26 06:01:02 volumiograf volumio[908]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100 Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: soundcloud , search Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: radio_paradise , search Jul 26 06:01:02 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: spop , search Jul 26 06:01:03 volumiograf volumio[908]: info: Fehler bei der Kommunikation mit SHOUTCAST Jul 26 06:01:04 volumiograf volumio[908]: error: Search in plugin soundcloud timed out Jul 26 06:01:04 volumiograf volumio[908]: error: Search in plugin ytmusic timed out Jul 26 06:01:04 volumiograf volumio[908]: info: All search sources collected, pushing search results Jul 26 06:01:12 volumiograf volumio[908]: error: Search in plugin webradio timed out Jul 26 06:01:12 volumiograf volumio[908]: error: Search in plugin soundcloud timed out Jul 26 06:01:12 volumiograf volumio[908]: error: Search in plugin ytmusic timed out Jul 26 06:01:12 volumiograf volumio[908]: error: Search in plugin spop timed out Jul 26 06:01:12 volumiograf volumio[908]: info: All search sources collected, pushing search results Jul 26 06:01:12 volumiograf volumio[908]: error: Search in plugin soundcloud timed out Jul 26 06:01:12 volumiograf volumio[908]: error: Search in plugin ytmusic timed out Jul 26 06:01:12 volumiograf volumio[908]: error: Search in plugin spop timed out Jul 26 06:01:12 volumiograf volumio[908]: info: All search sources collected, pushing search results Jul 26 06:01:14 volumiograf volumio[908]: Upnp client error: Error: This socket has been ended by the other party Jul 26 06:01:14 volumiograf volumio[908]: Upnp client error: Error: This socket has been ended by the other party Jul 26 06:01:14 volumiograf volumio[908]: Upnp client error: Error: This socket has been ended by the other party Jul 26 06:01:15 volumiograf volumio[908]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jul 26 06:01:15 volumiograf volumio[908]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jul 26 06:01:15 volumiograf volumio[908]: error: Failed search in plugin webradio: Error: Unable to resolve or reject the same promise twice Jul 26 06:01:15 volumiograf volumio[908]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jul 26 06:01:16 volumiograf volumio[908]: error: Failed search in plugin spop: Error: Unable to resolve or reject the same promise twice Jul 26 06:01:17 volumiograf volumio[908]: error: Failed search in plugin spop: Error: Unable to resolve or reject the same promise twice Jul 26 06:01:26 volumiograf volumio[908]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jul 26 06:01:47 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 26 06:01:47 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:01:53 volumiograf volumio[908]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jul 26 06:01:53 volumiograf volumio[908]: info: Preload queue cleared Jul 26 06:01:54 volumiograf volumio[908]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/volumio/app/plugins/miscellanea/albumart/icons/fa-tags.svg' Jul 26 06:01:56 volumiograf volumio[908]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 06:01:56 volumiograf volumio[908]: Error: getaddrinfo ENOTFOUND a-v2.sndcdn.com Jul 26 06:01:56 volumiograf volumio[908]: at GetAddrInfoReqWrap.onlookup [as oncomplete] (dns.js:67:26) { Jul 26 06:01:56 volumiograf volumio[908]: errno: -3007, Jul 26 06:01:56 volumiograf volumio[908]: code: 'ENOTFOUND', Jul 26 06:01:56 volumiograf volumio[908]: syscall: 'getaddrinfo', Jul 26 06:01:56 volumiograf volumio[908]: hostname: 'a-v2.sndcdn.com' Jul 26 06:01:56 volumiograf volumio[908]: } Jul 26 06:01:56 volumiograf volumio[908]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 26 06:01:58 volumiograf sudo[31719]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-26 06:00 Jul 26 06:01:58 volumiograf sudo[31719]: 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="4b122b2365bb8c09786cd63b50d1ea6db780eb4e" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="49f98390f2d84c6549f33dc85b694fbd99e4c720" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 04 Jun 2024 08:41:12 PM CEST" VOLUMIO_VERSION="3.703" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="8e78a6e3f56f1bcbbd1760812129a8e9"