-- Logs begin at Mon 2026-01-26 23:51:39 AEST, end at Wed 2026-01-28 15:18:23 AEST. -- Jan 28 15:17:02 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 28 15:17:06 volumio kernel: hwmon hwmon1: Voltage normalised Jan 28 15:17:12 volumio volumio[937]: info: Saving local item radio-favourites Jan 28 15:17:12 volumio volumio[937]: info: Pushing Favourites {"uri":"http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99502708","favourite":false} Jan 28 15:17:12 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 28 15:17:19 volumio kernel: hwmon hwmon1: Voltage normalised Jan 28 15:17:21 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::ClearQueue Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::stPlaybackTimer Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::serviceStop Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::serviceStop Jan 28 15:17:21 volumio volumio[937]: info: [1769577441674] ControllerWebradio::stop Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::clearPlayQueue Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::addQueueItems Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::addQueueItems Jan 28 15:17:21 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:21 volumio volumio[937]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1796288 Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::volumioPlay Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::play index 0 Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::play index undefined Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::startPlaybackTimer Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: [1769577441691] ControllerWebradio::clearAddPlayTrack Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 15:17:21 volumio volumio[937]: info: Jan 28 15:17:21 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:21 volumio volumio[937]: info: sendMpdCommand stop took 20 milliseconds Jan 28 15:17:21 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:21 volumio volumio[937]: info: sendMpdCommand stop took 4 milliseconds Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clear Jan 28 15:17:21 volumio volumio[937]: info: Jan 28 15:17:21 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:21 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:21 volumio volumio[937]: info: Jan 28 15:17:21 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:21 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:21 volumio volumio[937]: info: Jan 28 15:17:21 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:21 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:21 volumio volumio[937]: info: sendMpdCommand status took 5 milliseconds Jan 28 15:17:21 volumio volumio[937]: info: sendMpdCommand clear took 4 milliseconds Jan 28 15:17:21 volumio volumio[937]: info: sendMpdCommand status took 3 milliseconds Jan 28 15:17:21 volumio volumio[937]: info: sendMpdCommand status took 2 milliseconds Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1796288" Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:21 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 28 15:17:21 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:21 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:21 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:21 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 28 15:17:21 volumio volumio[937]: info: ------------------------------ 24ms Jan 28 15:17:21 volumio volumio[937]: info: ------------------------------ 24ms Jan 28 15:17:21 volumio volumio[937]: info: Jan 28 15:17:21 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:21 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:21 volumio volumio[937]: info: Jan 28 15:17:21 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:21 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:21 volumio volumio[937]: error: updateQueue error: null Jan 28 15:17:21 volumio volumio[937]: info: ------------------------------ 27ms Jan 28 15:17:21 volumio volumio[937]: info: sendMpdCommand playlistinfo took 25 milliseconds Jan 28 15:17:21 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:21 volumio volumio[937]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 28 15:17:21 volumio volumio[937]: info: ------------------------------ 33ms Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1796288" took 1300 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand play Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:23 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 1282ms Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 1281ms Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:23 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:23 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand play took 8 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 7ms Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 4ms Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 3ms Jan 28 15:17:23 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand status took 18 milliseconds Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand status took 21 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand status took 19 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: 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":"85.195.72.226:18576","artist":"(#1 - 20/100) RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 28ms Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:23 volumio volumio[937]: info: Jan 28 15:17:23 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand status took 10 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand playlistinfo took 8 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand playlistinfo took 7 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand status took 4 milliseconds Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand status took 3 milliseconds Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: 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":"85.195.72.226:18576","artist":"(#1 - 20/100) RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:23 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: 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":"85.195.72.226:18576","artist":"(#1 - 20/100) RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:23 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 71ms Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 70ms Jan 28 15:17:23 volumio volumio[937]: info: sendMpdCommand playlistinfo took 55 milliseconds Jan 28 15:17:23 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: 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":"85.195.72.226:18576","artist":"(#1 - 20/100) RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:23 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: 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":"85.195.72.226:18576","artist":"(#1 - 20/100) RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:23 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: 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":"85.195.72.226:18576","artist":"(#1 - 20/100) RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:23 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:23 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:23 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 109ms Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 103ms Jan 28 15:17:23 volumio volumio[937]: info: ------------------------------ 103ms Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:24 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:24 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 6ms Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand status took 5 milliseconds Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:24 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:24 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 10ms Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand status took 9 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:24 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:24 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":205,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"85.195.72.226:18576","artist":"RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:24 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:24 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 32ms Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:24 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:24 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:24 volumio volumio[937]: info: Jan 28 15:17:24 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 31ms Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand status took 31 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 29ms Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand status took 26 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand playlistinfo took 27 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 8ms Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand status took 7 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 7ms Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand status took 5 milliseconds Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:24 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:24 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":297,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mayday - Revenge","artist":"RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:24 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:24 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 56ms Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 28 15:17:24 volumio volumio[937]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:24 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:24 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:24 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":759,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mayday - Revenge","artist":"RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:24 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:24 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:24 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:24 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mayday - Revenge","artist":"RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:24 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:24 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:24 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:24 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mayday - Revenge","artist":"RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:24 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:24 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:24 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:24 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":884,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Mayday - Revenge","artist":"RBI Radio","album":null,"uri":"http://85.195.72.226:18576","trackType":"226:18576"} Jan 28 15:17:24 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:24 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:24 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 100ms Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 98ms Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 76ms Jan 28 15:17:24 volumio volumio[937]: info: ------------------------------ 75ms Jan 28 15:17:27 volumio kernel: hwmon hwmon1: Voltage normalised Jan 28 15:17:29 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 28 15:17:35 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::ClearQueue Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::stPlaybackTimer Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::serviceStop Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::serviceStop Jan 28 15:17:35 volumio volumio[937]: info: [1769577455502] ControllerWebradio::stop Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::clearPlayQueue Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::addQueueItems Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::addQueueItems Jan 28 15:17:35 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:35 volumio volumio[937]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99606252 Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::volumioPlay Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::play index 0 Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::play index undefined Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::startPlaybackTimer Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: [1769577455517] ControllerWebradio::clearAddPlayTrack Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand stop took 20 milliseconds Jan 28 15:17:35 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand stop took 5 milliseconds Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clear Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:35 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:35 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:35 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand status took 6 milliseconds Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand clear took 5 milliseconds Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand status took 5 milliseconds Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand status took 3 milliseconds Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99606252" Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:35 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 28 15:17:35 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:35 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:35 volumio volumio[937]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 20ms Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 19ms Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:35 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:35 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:35 volumio volumio[937]: error: updateQueue error: null Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 22ms Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand playlistinfo took 19 milliseconds Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:35 volumio volumio[937]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 29ms Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99606252" took 228 milliseconds Jan 28 15:17:35 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 28 15:17:35 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand play Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:35 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 215ms Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 213ms Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:35 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:35 volumio volumio[937]: info: Jan 28 15:17:35 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:35 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:35 volumio volumio[937]: info: sendMpdCommand play took 4 milliseconds Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 4ms Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 3ms Jan 28 15:17:35 volumio volumio[937]: info: ------------------------------ 2ms Jan 28 15:17:37 volumio volumio[937]: info: Jan 28 15:17:37 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:37 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:37 volumio volumio[937]: info: Jan 28 15:17:37 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:37 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:37 volumio volumio[937]: info: Jan 28 15:17:37 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:37 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand status took 7 milliseconds Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand status took 6 milliseconds Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand status took 10 milliseconds Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand clearerror took 6 milliseconds Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand clearerror took 6 milliseconds Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:37 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:37 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 16/200) Desert Underground Radio","album":null,"uri":"https://46.105.122.141:6878/","trackType":"141:6878/"} Jan 28 15:17:37 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: No code Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:37 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 16/200) Desert Underground Radio","album":null,"uri":"https://46.105.122.141:6878/","trackType":"141:6878/"} Jan 28 15:17:37 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: No code Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: ------------------------------ 30ms Jan 28 15:17:37 volumio volumio[937]: info: ------------------------------ 30ms Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand clearerror took 23 milliseconds Jan 28 15:17:37 volumio volumio[937]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 28 15:17:37 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:37 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:37 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 16/200) Desert Underground Radio","album":null,"uri":"https://46.105.122.141:6878/","trackType":"141:6878/"} Jan 28 15:17:37 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: No code Jan 28 15:17:37 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:37 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:37 volumio volumio[937]: info: ------------------------------ 45ms Jan 28 15:17:40 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:40 volumio volumio[937]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::ClearQueue Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:40 volumio volumio[937]: info: CorePlayQueue::clearPlayQueue Jan 28 15:17:40 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:40 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::addQueueItems Jan 28 15:17:40 volumio volumio[937]: info: CorePlayQueue::addQueueItems Jan 28 15:17:40 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:40 volumio volumio[937]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99509176 Jan 28 15:17:40 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 28 15:17:40 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:40 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Jan 28 15:17:40 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Jan 28 15:17:40 volumio volumio[937]: info: CoreCommandRouter::volumioPlay Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::play index 0 Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::play index undefined Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:40 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::startPlaybackTimer Jan 28 15:17:40 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:40 volumio volumio[937]: info: [1769577460416] ControllerWebradio::clearAddPlayTrack Jan 28 15:17:40 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 15:17:40 volumio volumio[937]: info: sendMpdCommand stop took 3 milliseconds Jan 28 15:17:40 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clear Jan 28 15:17:40 volumio volumio[937]: info: Jan 28 15:17:40 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:40 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:40 volumio volumio[937]: info: sendMpdCommand clear took 2 milliseconds Jan 28 15:17:40 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99509176" Jan 28 15:17:40 volumio volumio[937]: info: Jan 28 15:17:40 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:40 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:40 volumio volumio[937]: info: Jan 28 15:17:40 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:40 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:40 volumio volumio[937]: error: updateQueue error: null Jan 28 15:17:40 volumio volumio[937]: info: ------------------------------ 6ms Jan 28 15:17:40 volumio volumio[937]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99509176" took 229 milliseconds Jan 28 15:17:40 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 28 15:17:40 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand play Jan 28 15:17:40 volumio volumio[937]: info: Jan 28 15:17:40 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:40 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:40 volumio volumio[937]: info: ------------------------------ 231ms Jan 28 15:17:40 volumio volumio[937]: info: ------------------------------ 229ms Jan 28 15:17:40 volumio volumio[937]: info: sendMpdCommand play took 2 milliseconds Jan 28 15:17:40 volumio volumio[937]: info: Jan 28 15:17:40 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:40 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:40 volumio volumio[937]: info: Jan 28 15:17:40 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:40 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:40 volumio volumio[937]: info: ------------------------------ 4ms Jan 28 15:17:40 volumio volumio[937]: info: ------------------------------ 2ms Jan 28 15:17:40 volumio volumio[937]: info: ------------------------------ 1ms Jan 28 15:17:43 volumio volumio[937]: info: Jan 28 15:17:43 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:43 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:43 volumio volumio[937]: info: Jan 28 15:17:43 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:43 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:43 volumio volumio[937]: info: Jan 28 15:17:43 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:43 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand status took 8 milliseconds Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand status took 7 milliseconds Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand status took 13 milliseconds Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand clearerror took 10 milliseconds Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand clearerror took 9 milliseconds Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:43 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:43 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.mp3","artist":"(#1 - 17/750) Best 70s","album":null,"uri":"https://c4.auracast.net:8040/radio.mp3","trackType":"mp3"} Jan 28 15:17:43 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: No code Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:43 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.mp3","artist":"(#1 - 17/750) Best 70s","album":null,"uri":"https://c4.auracast.net:8040/radio.mp3","trackType":"mp3"} Jan 28 15:17:43 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: No code Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: ------------------------------ 54ms Jan 28 15:17:43 volumio volumio[937]: info: ------------------------------ 53ms Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand clearerror took 46 milliseconds Jan 28 15:17:43 volumio volumio[937]: info: sendMpdCommand playlistinfo took 44 milliseconds Jan 28 15:17:43 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:43 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:43 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"radio.mp3","artist":"(#1 - 17/750) Best 70s","album":null,"uri":"https://c4.auracast.net:8040/radio.mp3","trackType":"mp3"} Jan 28 15:17:43 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: No code Jan 28 15:17:43 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:43 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:43 volumio volumio[937]: info: ------------------------------ 76ms Jan 28 15:17:46 volumio kernel: hwmon hwmon1: Voltage normalised Jan 28 15:17:47 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:47 volumio volumio[937]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::ClearQueue Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:47 volumio volumio[937]: info: CorePlayQueue::clearPlayQueue Jan 28 15:17:47 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:47 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::addQueueItems Jan 28 15:17:47 volumio volumio[937]: info: CorePlayQueue::addQueueItems Jan 28 15:17:47 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:47 volumio volumio[937]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99565020 Jan 28 15:17:47 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 28 15:17:47 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:47 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Jan 28 15:17:47 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Jan 28 15:17:47 volumio volumio[937]: info: CoreCommandRouter::volumioPlay Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::play index 0 Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::play index undefined Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:47 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::startPlaybackTimer Jan 28 15:17:47 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:47 volumio volumio[937]: info: [1769577467668] ControllerWebradio::clearAddPlayTrack Jan 28 15:17:47 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 15:17:47 volumio volumio[937]: info: sendMpdCommand stop took 2 milliseconds Jan 28 15:17:47 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clear Jan 28 15:17:47 volumio volumio[937]: info: Jan 28 15:17:47 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:47 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:47 volumio volumio[937]: info: sendMpdCommand clear took 1 milliseconds Jan 28 15:17:47 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99565020" Jan 28 15:17:47 volumio volumio[937]: info: Jan 28 15:17:47 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:47 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:47 volumio volumio[937]: info: Jan 28 15:17:47 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:47 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:47 volumio volumio[937]: error: updateQueue error: null Jan 28 15:17:47 volumio volumio[937]: info: ------------------------------ 3ms Jan 28 15:17:47 volumio volumio[937]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99565020" took 225 milliseconds Jan 28 15:17:47 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 28 15:17:47 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand play Jan 28 15:17:47 volumio volumio[937]: info: Jan 28 15:17:47 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:47 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:47 volumio volumio[937]: info: ------------------------------ 226ms Jan 28 15:17:47 volumio volumio[937]: info: ------------------------------ 225ms Jan 28 15:17:47 volumio volumio[937]: info: Jan 28 15:17:47 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:47 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:47 volumio volumio[937]: info: Jan 28 15:17:47 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:47 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:47 volumio volumio[937]: info: sendMpdCommand play took 4 milliseconds Jan 28 15:17:47 volumio volumio[937]: info: ------------------------------ 4ms Jan 28 15:17:47 volumio volumio[937]: info: ------------------------------ 2ms Jan 28 15:17:47 volumio volumio[937]: info: ------------------------------ 1ms Jan 28 15:17:48 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 28 15:17:50 volumio volumio[937]: info: Jan 28 15:17:50 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:50 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:50 volumio volumio[937]: info: Jan 28 15:17:50 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:50 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:50 volumio volumio[937]: info: Jan 28 15:17:50 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:50 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand status took 8 milliseconds Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand status took 7 milliseconds Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clearerror Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand status took 15 milliseconds Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand clearerror took 10 milliseconds Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand clearerror took 9 milliseconds Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand playlistinfo took 6 milliseconds Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:50 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:50 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 9/500) Radiowaves","album":null,"uri":"https://quincy.torontocast.com:3650/","trackType":"com:3650/"} Jan 28 15:17:50 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: No code Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:50 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 9/500) Radiowaves","album":null,"uri":"https://quincy.torontocast.com:3650/","trackType":"com:3650/"} Jan 28 15:17:50 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: No code Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: ------------------------------ 50ms Jan 28 15:17:50 volumio volumio[937]: info: ------------------------------ 50ms Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand clearerror took 43 milliseconds Jan 28 15:17:50 volumio volumio[937]: info: sendMpdCommand playlistinfo took 40 milliseconds Jan 28 15:17:50 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:50 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:50 volumio volumio[937]: verbose: STATE SERVICE {"status":"stop","position":0,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 9/500) Radiowaves","album":null,"uri":"https://quincy.torontocast.com:3650/","trackType":"com:3650/"} Jan 28 15:17:50 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::syncState stateService stop Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: No code Jan 28 15:17:50 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:50 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:50 volumio volumio[937]: info: ------------------------------ 73ms Jan 28 15:17:53 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:53 volumio volumio[937]: info: CoreCommandRouter::volumioReplaceandPlayItems Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::ClearQueue Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:53 volumio volumio[937]: info: CorePlayQueue::clearPlayQueue Jan 28 15:17:53 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:53 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::addQueueItems Jan 28 15:17:53 volumio volumio[937]: info: CorePlayQueue::addQueueItems Jan 28 15:17:53 volumio volumio[937]: info: Preload queue cleared Jan 28 15:17:53 volumio volumio[937]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99578208 Jan 28 15:17:53 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jan 28 15:17:53 volumio volumio[937]: info: CoreCommandRouter::volumioPushQueue Jan 28 15:17:53 volumio volumio[937]: info: CorePlayQueue::saveQueue Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::updateTrackBlock Jan 28 15:17:53 volumio volumio[937]: info: CorePlayQueue::getTrackBlock Jan 28 15:17:53 volumio volumio[937]: info: CoreCommandRouter::volumioPlay Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::play index 0 Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::stop Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::play index undefined Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService undefined Jan 28 15:17:53 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::startPlaybackTimer Jan 28 15:17:53 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:53 volumio volumio[937]: info: [1769577473119] ControllerWebradio::clearAddPlayTrack Jan 28 15:17:53 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand stop Jan 28 15:17:53 volumio volumio[937]: info: sendMpdCommand stop took 2 milliseconds Jan 28 15:17:53 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand clear Jan 28 15:17:53 volumio volumio[937]: info: Jan 28 15:17:53 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:53 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:53 volumio volumio[937]: info: sendMpdCommand clear took 1 milliseconds Jan 28 15:17:53 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99578208" Jan 28 15:17:53 volumio volumio[937]: info: Jan 28 15:17:53 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:53 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:53 volumio volumio[937]: info: Jan 28 15:17:53 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:53 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:53 volumio volumio[937]: error: updateQueue error: null Jan 28 15:17:53 volumio volumio[937]: info: ------------------------------ 5ms Jan 28 15:17:53 volumio volumio[937]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99578208" took 227 milliseconds Jan 28 15:17:53 volumio volumio[937]: info: CoreStateMachine::setConsumeUpdateService mpd Jan 28 15:17:53 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand play Jan 28 15:17:53 volumio volumio[937]: info: Jan 28 15:17:53 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:53 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:53 volumio volumio[937]: info: ------------------------------ 229ms Jan 28 15:17:53 volumio volumio[937]: info: ------------------------------ 228ms Jan 28 15:17:53 volumio volumio[937]: info: Jan 28 15:17:53 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:53 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:53 volumio volumio[937]: info: Jan 28 15:17:53 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:53 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:53 volumio volumio[937]: info: sendMpdCommand play took 7 milliseconds Jan 28 15:17:53 volumio volumio[937]: info: ------------------------------ 6ms Jan 28 15:17:53 volumio volumio[937]: info: ------------------------------ 4ms Jan 28 15:17:53 volumio volumio[937]: info: ------------------------------ 3ms Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 21 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 20 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 22 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 4 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 3 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"","artist":"(#1 - 6/0) A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus stop Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"","artist":"(#1 - 6/0) A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 38ms Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 42ms Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 21 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 20 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 4 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 3 milliseconds Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"","artist":"(#1 - 6/0) A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"","artist":"(#1 - 6/0) A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 70ms Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 56ms Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 34 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 34 milliseconds Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"","artist":"(#1 - 6/0) A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"","artist":"(#1 - 6/0) A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 62ms Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 62ms Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:54 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:54 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:54 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 10ms Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 8 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 8ms Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 11 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 10ms Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 9 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":148,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"","artist":"A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 35ms Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:54 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 23 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 22 milliseconds Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":800,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Trammps - Disco Inferno","artist":"A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: verbose: STATE SERVICE {"status":"play","position":0,"seek":857,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Trammps - Disco Inferno","artist":"A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 61ms Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 59ms Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:54 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces system playlist update Jan 28 15:17:54 volumio volumio[937]: info: Ignoring MPD Status Update Jan 28 15:17:54 volumio volumio[937]: info: Jan 28 15:17:54 volumio volumio[937]: ---------------------------- MPD announces state update: player Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::getState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand status Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 41ms Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 40 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 14ms Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 12 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 11ms Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand status took 11 milliseconds Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseState Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 5 milliseconds Jan 28 15:17:54 volumio volumio[937]: info: sendMpdCommand playlistinfo took 4 milliseconds Jan 28 15:17:54 volumio volumio[937]: verbose: ControllerMpd::parseTrackInfo Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"The Trammps - Disco Inferno","artist":"A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"The Trammps - Disco Inferno","artist":"A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ControllerMpd::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::servicePushState Jan 28 15:17:54 volumio volumio[937]: info: CorePlayQueue::getTrack 0 Jan 28 15:17:54 volumio volumio[937]: 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":"The Trammps - Disco Inferno","artist":"A_A 70s","album":null,"uri":"http://62.210.204.2:8000/stream/15/","trackType":""} Jan 28 15:17:54 volumio volumio[937]: verbose: CURRENT POSITION 0 Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState stateService play Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::syncState currentStatus play Jan 28 15:17:54 volumio volumio[937]: info: Received an update from plugin. extracting info from payload Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: CoreStateMachine::pushState Jan 28 15:17:54 volumio volumio[937]: info: CoreCommandRouter::volumioPushState Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 84ms Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 56ms Jan 28 15:17:54 volumio volumio[937]: info: ------------------------------ 55ms Jan 28 15:17:58 volumio kernel: hwmon hwmon1: Voltage normalised Jan 28 15:18:02 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 28 15:18:08 volumio kernel: hwmon hwmon1: Voltage normalised Jan 28 15:18:09 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 28 15:18:09 volumio volumio[937]: info: CURURI: genres:// Jan 28 15:18:10 volumio volumio[937]: info: Preload queue cleared Jan 28 15:18:10 volumio volumio[937]: 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' Jan 28 15:18:13 volumio kernel: hwmon hwmon1: Undervoltage detected! Jan 28 15:18:20 volumio volumio[937]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jan 28 15:18:20 volumio volumio[937]: info: CURURI: genres://1970s Jan 28 15:18:20 volumio volumio[937]: info: Preload queue cleared Jan 28 15:18:20 volumio volumio[937]: info: Preload queue cleared Jan 28 15:18:21 volumio volumio[937]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 15:18:21 volumio volumio[937]: Error: connect ECONNREFUSED 158.69.209.125:443 Jan 28 15:18:21 volumio volumio[937]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Jan 28 15:18:21 volumio volumio[937]: errno: -111, Jan 28 15:18:21 volumio volumio[937]: code: 'ECONNREFUSED', Jan 28 15:18:21 volumio volumio[937]: syscall: 'connect', Jan 28 15:18:21 volumio volumio[937]: address: '158.69.209.125', Jan 28 15:18:21 volumio volumio[937]: port: 443 Jan 28 15:18:21 volumio volumio[937]: } Jan 28 15:18:21 volumio volumio[937]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 28 15:18:23 volumio sudo[20119]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2026-01-28 15:17 Jan 28 15:18:23 volumio sudo[20119]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"