-- Logs begin at Wed 2025-01-01 14:31:48 UTC, end at Wed 2025-03-05 08:04:41 UTC. -- Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::ClearQueue Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:04 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::stPlaybackTimer Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::serviceStop Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::serviceStop Mar 05 08:03:04 volumio-alex volumio[873]: info: [1741161784476] ControllerWebradio::stop Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::clearPlayQueue Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::addQueueItems Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::addQueueItems Mar 05 08:03:04 volumio-alex volumio[873]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99576270 Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPlay Mar 05 08:03:04 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::play index 0 Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:04 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::play index undefined Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::startPlaybackTimer Mar 05 08:03:04 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:04 volumio-alex volumio[873]: info: [1741161784491] ControllerWebradio::clearAddPlayTrack Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:03:04 volumio-alex volumio[873]: info: Mar 05 08:03:04 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:04 volumio-alex volumio[873]: info: sendMpdCommand stop took 37 milliseconds Mar 05 08:03:04 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:04 volumio-alex volumio[873]: info: sendMpdCommand stop took 23 milliseconds Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand clear Mar 05 08:03:04 volumio-alex volumio[873]: info: Mar 05 08:03:04 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:04 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:04 volumio-alex volumio[873]: info: sendMpdCommand status took 2 milliseconds Mar 05 08:03:04 volumio-alex volumio[873]: info: sendMpdCommand clear took 2 milliseconds Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99576270" Mar 05 08:03:04 volumio-alex volumio[873]: error: updateQueue error: null Mar 05 08:03:04 volumio-alex volumio[873]: info: ------------------------------ 4ms Mar 05 08:03:04 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:04 volumio-alex volumio[873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 05 08:03:04 volumio-alex volumio[873]: info: ------------------------------ 8ms Mar 05 08:03:04 volumio-alex volumio[873]: info: Mar 05 08:03:04 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:04 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:04 volumio-alex volumio[873]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99576270" took 207 milliseconds Mar 05 08:03:04 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 05 08:03:04 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand play Mar 05 08:03:04 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:03:04 volumio-alex volumio[873]: info: sendMpdCommand play took 1 milliseconds Mar 05 08:03:05 volumio-alex volumio[873]: info: Mar 05 08:03:05 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:05 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:05 volumio-alex volumio[873]: info: Mar 05 08:03:05 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:05 volumio-alex volumio[873]: info: sendMpdCommand status took 2 milliseconds Mar 05 08:03:05 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:05 volumio-alex volumio[873]: info: sendMpdCommand status took 1 milliseconds Mar 05 08:03:05 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:05 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:05 volumio-alex volumio[873]: 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":"livech1.mp3","artist":"(#1 - 888/5000) Top Radio FM 93.5","album":null,"uri":"http://202.129.206.187:8000/livech1.mp3","trackType":"mp3"} Mar 05 08:03:05 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus stop Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:05 volumio-alex volumio[873]: info: ------------------------------ 14ms Mar 05 08:03:05 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 9 milliseconds Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:05 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:05 volumio-alex volumio[873]: 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":"livech1.mp3","artist":"(#1 - 888/5000) Top Radio FM 93.5","album":null,"uri":"http://202.129.206.187:8000/livech1.mp3","trackType":"mp3"} Mar 05 08:03:05 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus play Mar 05 08:03:05 volumio-alex volumio[873]: info: Received an update from plugin. extracting info from payload Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:05 volumio-alex volumio[873]: info: ------------------------------ 23ms Mar 05 08:03:05 volumio-alex volumio[873]: info: Mar 05 08:03:05 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:05 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:05 volumio-alex volumio[873]: info: Mar 05 08:03:05 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:05 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:05 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:03:05 volumio-alex volumio[873]: info: sendMpdCommand status took 1 milliseconds Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:05 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 05 08:03:05 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:05 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:05 volumio-alex volumio[873]: 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":"livech1.mp3","artist":"Top Radio FM 93.5","album":null,"uri":"http://202.129.206.187:8000/livech1.mp3","trackType":"mp3"} Mar 05 08:03:05 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus play Mar 05 08:03:05 volumio-alex volumio[873]: info: Received an update from plugin. extracting info from payload Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:05 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:05 volumio-alex volumio[873]: info: ------------------------------ 16ms Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::ClearQueue Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:50 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::stPlaybackTimer Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::serviceStop Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::serviceStop Mar 05 08:03:50 volumio-alex volumio[873]: info: [1741161830672] ControllerWebradio::stop Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::clearPlayQueue Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::addQueueItems Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::addQueueItems Mar 05 08:03:50 volumio-alex volumio[873]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996 Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPlay Mar 05 08:03:50 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::play index 0 Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:50 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::play index undefined Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::startPlaybackTimer Mar 05 08:03:50 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:50 volumio-alex volumio[873]: info: [1741161830688] ControllerWebradio::clearAddPlayTrack Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:03:50 volumio-alex volumio[873]: info: sendMpdCommand stop took 62 milliseconds Mar 05 08:03:50 volumio-alex volumio[873]: info: Mar 05 08:03:50 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:50 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:50 volumio-alex volumio[873]: info: sendMpdCommand stop took 46 milliseconds Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand clear Mar 05 08:03:50 volumio-alex volumio[873]: info: Mar 05 08:03:50 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:50 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:50 volumio-alex volumio[873]: info: sendMpdCommand status took 2 milliseconds Mar 05 08:03:50 volumio-alex volumio[873]: info: sendMpdCommand clear took 1 milliseconds Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" Mar 05 08:03:50 volumio-alex volumio[873]: error: updateQueue error: null Mar 05 08:03:50 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:03:50 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:50 volumio-alex volumio[873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 05 08:03:50 volumio-alex volumio[873]: info: ------------------------------ 6ms Mar 05 08:03:50 volumio-alex volumio[873]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99497996" took 239 milliseconds Mar 05 08:03:50 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 05 08:03:50 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand play Mar 05 08:03:50 volumio-alex volumio[873]: info: Mar 05 08:03:50 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:50 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:50 volumio-alex volumio[873]: info: sendMpdCommand play took 1 milliseconds Mar 05 08:03:50 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::ClearQueue Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:57 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:57 volumio-alex volumio[873]: info: CorePlayQueue::clearPlayQueue Mar 05 08:03:57 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::addQueueItems Mar 05 08:03:57 volumio-alex volumio[873]: info: CorePlayQueue::addQueueItems Mar 05 08:03:57 volumio-alex volumio[873]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397 Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 05 08:03:57 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:03:57 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPlay Mar 05 08:03:57 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::play index 0 Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:57 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::play index undefined Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:57 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::startPlaybackTimer Mar 05 08:03:57 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:57 volumio-alex volumio[873]: info: [1741161837048] ControllerWebradio::clearAddPlayTrack Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:03:57 volumio-alex volumio[873]: info: Mar 05 08:03:57 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:57 volumio-alex volumio[873]: info: sendMpdCommand stop took 3 milliseconds Mar 05 08:03:57 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand clear Mar 05 08:03:57 volumio-alex volumio[873]: info: Mar 05 08:03:57 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:57 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:57 volumio-alex volumio[873]: info: sendMpdCommand status took 2 milliseconds Mar 05 08:03:57 volumio-alex volumio[873]: info: sendMpdCommand clear took 2 milliseconds Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" Mar 05 08:03:57 volumio-alex volumio[873]: error: updateQueue error: null Mar 05 08:03:57 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:03:57 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:57 volumio-alex volumio[873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 05 08:03:57 volumio-alex volumio[873]: info: ------------------------------ 6ms Mar 05 08:03:57 volumio-alex volumio[873]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" took 214 milliseconds Mar 05 08:03:57 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 05 08:03:57 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand play Mar 05 08:03:57 volumio-alex volumio[873]: info: Mar 05 08:03:57 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:57 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:57 volumio-alex volumio[873]: info: sendMpdCommand play took 2 milliseconds Mar 05 08:03:57 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:03:59 volumio-alex volumio[873]: info: Mar 05 08:03:59 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:59 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:59 volumio-alex volumio[873]: info: Mar 05 08:03:59 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand status took 3 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:59 volumio-alex volumio[873]: info: Mar 05 08:03:59 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:59 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:59 volumio-alex volumio[873]: info: Mar 05 08:03:59 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:59 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand status took 6 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:59 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:59 volumio-alex volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Hurricane - Poljupci U Zoru","artist":"OKRADIO-94.2FM","album":null,"uri":"https://sslstream.okradio.net:80/","trackType":"net:80/"} Mar 05 08:03:59 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus stop Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:59 volumio-alex volumio[873]: info: ------------------------------ 18ms Mar 05 08:03:59 volumio-alex volumio[873]: info: ------------------------------ 10ms Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand status took 10 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 8 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:59 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:59 volumio-alex volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Hurricane - Poljupci U Zoru","artist":"OKRADIO-94.2FM","album":null,"uri":"https://sslstream.okradio.net:80/","trackType":"net:80/"} Mar 05 08:03:59 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus play Mar 05 08:03:59 volumio-alex volumio[873]: info: Received an update from plugin. extracting info from payload Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:59 volumio-alex volumio[873]: info: ------------------------------ 30ms Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 16 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:59 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:59 volumio-alex volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"124 Kbps","isStreaming":false,"title":"Hurricane - Poljupci U Zoru","artist":"OKRADIO-94.2FM","album":null,"uri":"https://sslstream.okradio.net:80/","trackType":"net:80/"} Mar 05 08:03:59 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus play Mar 05 08:03:59 volumio-alex volumio[873]: info: Received an update from plugin. extracting info from payload Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:59 volumio-alex volumio[873]: info: ------------------------------ 35ms Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::ClearQueue Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:59 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::stPlaybackTimer Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::serviceStop Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::serviceStop Mar 05 08:03:59 volumio-alex volumio[873]: info: [1741161839701] ControllerWebradio::stop Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::clearPlayQueue Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::addQueueItems Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::addQueueItems Mar 05 08:03:59 volumio-alex volumio[873]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPlay Mar 05 08:03:59 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::play index 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:59 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::play index undefined Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: CoreStateMachine::startPlaybackTimer Mar 05 08:03:59 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:03:59 volumio-alex volumio[873]: info: [1741161839717] ControllerWebradio::clearAddPlayTrack Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:03:59 volumio-alex volumio[873]: info: Mar 05 08:03:59 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand stop took 190 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand stop took 173 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand clear Mar 05 08:03:59 volumio-alex volumio[873]: info: Mar 05 08:03:59 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:03:59 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand status took 2 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand clear took 1 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" Mar 05 08:03:59 volumio-alex volumio[873]: error: updateQueue error: null Mar 05 08:03:59 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:03:59 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 2 milliseconds Mar 05 08:03:59 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:03:59 volumio-alex volumio[873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 05 08:03:59 volumio-alex volumio[873]: info: ------------------------------ 7ms Mar 05 08:04:00 volumio-alex volumio[873]: info: Mar 05 08:04:00 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:04:00 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" took 210 milliseconds Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand play Mar 05 08:04:00 volumio-alex volumio[873]: info: ------------------------------ 2ms Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand play took 1 milliseconds Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreCommandRouter::volumioReplaceandPlayItems Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::ClearQueue Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:04:00 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:04:00 volumio-alex volumio[873]: info: CorePlayQueue::clearPlayQueue Mar 05 08:04:00 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::addQueueItems Mar 05 08:04:00 volumio-alex volumio[873]: info: CorePlayQueue::addQueueItems Mar 05 08:04:00 volumio-alex volumio[873]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397 Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Mar 05 08:04:00 volumio-alex volumio[873]: info: CorePlayQueue::saveQueue Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushQueue Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::updateTrackBlock Mar 05 08:04:00 volumio-alex volumio[873]: info: CorePlayQueue::getTrackBlock Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPlay Mar 05 08:04:00 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::play index 0 Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::stop Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:04:00 volumio-alex volumio[873]: verbose: UNSET VOLATILE Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::play index undefined Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService undefined Mar 05 08:04:00 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::startPlaybackTimer Mar 05 08:04:00 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:04:00 volumio-alex volumio[873]: info: [1741161840677] ControllerWebradio::clearAddPlayTrack Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand stop Mar 05 08:04:00 volumio-alex volumio[873]: info: Mar 05 08:04:00 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand stop took 4 milliseconds Mar 05 08:04:00 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand clear Mar 05 08:04:00 volumio-alex volumio[873]: info: Mar 05 08:04:00 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:04:00 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand status took 2 milliseconds Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand clear took 2 milliseconds Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" Mar 05 08:04:00 volumio-alex volumio[873]: error: updateQueue error: null Mar 05 08:04:00 volumio-alex volumio[873]: info: ------------------------------ 3ms Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 3 milliseconds Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:04:00 volumio-alex volumio[873]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Mar 05 08:04:00 volumio-alex volumio[873]: info: ------------------------------ 9ms Mar 05 08:04:00 volumio-alex volumio[873]: info: Mar 05 08:04:00 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:04:00 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99530397" took 214 milliseconds Mar 05 08:04:00 volumio-alex volumio[873]: info: CoreStateMachine::setConsumeUpdateService mpd Mar 05 08:04:00 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand play Mar 05 08:04:00 volumio-alex volumio[873]: info: ------------------------------ 2ms Mar 05 08:04:00 volumio-alex volumio[873]: info: sendMpdCommand play took 2 milliseconds Mar 05 08:04:02 volumio-alex volumio[873]: info: Mar 05 08:04:02 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:04:02 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:04:02 volumio-alex volumio[873]: info: sendMpdCommand status took 1 milliseconds Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:04:02 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:04:02 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:04:02 volumio-alex volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":"(#1 - 1532/6500) OKRADIO-94.2FM","album":null,"uri":"https://sslstream.okradio.net:80/","trackType":"net:80/"} Mar 05 08:04:02 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus stop Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:04:02 volumio-alex volumio[873]: info: ------------------------------ 11ms Mar 05 08:04:02 volumio-alex volumio[873]: info: Mar 05 08:04:02 volumio-alex volumio[873]: ---------------------------- MPD announces system playlist update Mar 05 08:04:02 volumio-alex volumio[873]: info: Ignoring MPD Status Update Mar 05 08:04:02 volumio-alex volumio[873]: info: Mar 05 08:04:02 volumio-alex volumio[873]: ---------------------------- MPD announces state update: player Mar 05 08:04:02 volumio-alex volumio[873]: info: ControllerMpd::getState Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand status Mar 05 08:04:02 volumio-alex volumio[873]: info: ------------------------------ 4ms Mar 05 08:04:02 volumio-alex volumio[873]: info: sendMpdCommand status took 3 milliseconds Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::parseState Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::sendMpdCommand playlistinfo Mar 05 08:04:02 volumio-alex volumio[873]: info: sendMpdCommand playlistinfo took 1 milliseconds Mar 05 08:04:02 volumio-alex volumio[873]: verbose: ControllerMpd::parseTrackInfo Mar 05 08:04:02 volumio-alex volumio[873]: info: ControllerMpd::pushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::servicePushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CorePlayQueue::getTrack 0 Mar 05 08:04:02 volumio-alex volumio[873]: verbose: STATE SERVICE {"status":"play","position":0,"seek":880,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"123 Kbps","isStreaming":false,"title":"Hurricane - Poljupci U Zoru","artist":"OKRADIO-94.2FM","album":null,"uri":"https://sslstream.okradio.net:80/","trackType":"net:80/"} Mar 05 08:04:02 volumio-alex volumio[873]: verbose: CURRENT POSITION 0 Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreStateMachine::syncState stateService play Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreStateMachine::syncState currentStatus play Mar 05 08:04:02 volumio-alex volumio[873]: info: Received an update from plugin. extracting info from payload Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreStateMachine::pushState Mar 05 08:04:02 volumio-alex volumio[873]: info: CoreCommandRouter::volumioPushState Mar 05 08:04:02 volumio-alex volumio[873]: info: ------------------------------ 16ms Mar 05 08:04:39 volumio-alex volumio[873]: Searching plugin music_service/webradio Mar 05 08:04:39 volumio-alex volumio[873]: info: CoreCommandRouter::executeOnPlugin: webradio , search Mar 05 08:04:41 volumio-alex volumio[873]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 08:04:41 volumio-alex volumio[873]: Error: connect ETIMEDOUT 157.240.6.35:80 Mar 05 08:04:41 volumio-alex volumio[873]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Mar 05 08:04:41 volumio-alex volumio[873]: errno: -110, Mar 05 08:04:41 volumio-alex volumio[873]: code: 'ETIMEDOUT', Mar 05 08:04:41 volumio-alex volumio[873]: syscall: 'connect', Mar 05 08:04:41 volumio-alex volumio[873]: address: '157.240.6.35', Mar 05 08:04:41 volumio-alex volumio[873]: port: 80 Mar 05 08:04:41 volumio-alex volumio[873]: } Mar 05 08:04:41 volumio-alex volumio[873]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 05 08:04:41 volumio-alex sudo[1556]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-05 08:03 Mar 05 08:04:41 volumio-alex sudo[1556]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="1f061e035f7cb2799b32d3520aa8e55cd07df6f9" VOLUMIO_FE_VERSION="9971a09df9c3edfdedf2ecf438999be8aba9db68" VOLUMIO_FE3_VERSION="3974def988c7b2392ddc85f9b8cb4692d5e8fda9" VOLUMIO_BE_VERSION="b3c53a818b9b3d0e5c13c9d346c4d613c4ca426f" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 11 Jul 2022 04:03:33 PM CEST" VOLUMIO_VERSION="3.324" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="5b2f59e6e90e57f326ca25c7ca839d52"