-- Logs begin at Wed 2024-10-23 16:55:27 UTC, end at Wed 2024-10-23 23:06:44 UTC. -- Oct 23 23:05:01 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 23 23:05:03 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:08 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 23:05:08 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 23:05:08 volumio volumio[3597]: info: Discovery: Getting this device information Oct 23 23:05:08 volumio volumio[3597]: info: CoreCommandRouter::volumioGetState Oct 23 23:05:08 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 23:05:24 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::stPlaybackTimer Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::serviceStop Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::serviceStop Oct 23 23:05:24 volumio volumio[3597]: info: [1729724724105] ControllerWebradio::stop Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:05:24 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:24 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99560121 Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:05:24 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:24 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:05:24 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:24 volumio volumio[3597]: info: [1729724724122] ControllerWebradio::clearAddPlayTrack Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:05:24 volumio volumio[3597]: info: Oct 23 23:05:24 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:24 volumio volumio[3597]: info: sendMpdCommand stop took 26 milliseconds Oct 23 23:05:24 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:24 volumio volumio[3597]: info: sendMpdCommand stop took 9 milliseconds Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:05:24 volumio volumio[3597]: info: Oct 23 23:05:24 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:24 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:24 volumio volumio[3597]: info: sendMpdCommand status took 3 milliseconds Oct 23 23:05:24 volumio volumio[3597]: info: sendMpdCommand clear took 2 milliseconds Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99560121" Oct 23 23:05:24 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:05:24 volumio volumio[3597]: info: ------------------------------ 4ms Oct 23 23:05:24 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 23 23:05:24 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:24 volumio volumio[3597]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 23 23:05:24 volumio volumio[3597]: info: ------------------------------ 10ms Oct 23 23:05:25 volumio volumio[3597]: info: Oct 23 23:05:25 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:25 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:25 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99560121" took 1236 milliseconds Oct 23 23:05:25 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:05:25 volumio volumio[3597]: info: ------------------------------ 7ms Oct 23 23:05:25 volumio volumio[3597]: info: sendMpdCommand play took 5 milliseconds Oct 23 23:05:25 volumio volumio[3597]: info: Oct 23 23:05:25 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:25 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:25 volumio volumio[3597]: info: Oct 23 23:05:25 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:25 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:25 volumio volumio[3597]: info: sendMpdCommand status took 6 milliseconds Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:25 volumio volumio[3597]: info: sendMpdCommand status took 8 milliseconds Oct 23 23:05:25 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:25 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:25 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:25 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:25 volumio volumio[3597]: 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 - 28/800) Made in 80","album":null,"uri":"http://162.19.79.231:8002/","trackType":"231:8002/"} Oct 23 23:05:25 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:25 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:05:25 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:05:25 volumio volumio[3597]: info: ------------------------------ 24ms Oct 23 23:05:25 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 8 milliseconds Oct 23 23:05:25 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:25 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:25 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:25 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:25 volumio volumio[3597]: 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 - 28/800) Made in 80","album":null,"uri":"http://162.19.79.231:8002/","trackType":"231:8002/"} Oct 23 23:05:25 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:25 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:05:25 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:05:25 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:05:25 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:05:25 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:25 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:25 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:25 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:25 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:25 volumio volumio[3597]: info: ------------------------------ 48ms Oct 23 23:05:26 volumio volumio[3597]: info: Oct 23 23:05:26 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:26 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:26 volumio volumio[3597]: info: Oct 23 23:05:26 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:26 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:26 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:26 volumio volumio[3597]: info: ------------------------------ 3ms Oct 23 23:05:26 volumio volumio[3597]: info: sendMpdCommand status took 2 milliseconds Oct 23 23:05:26 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:26 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:26 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 1 milliseconds Oct 23 23:05:26 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:26 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:26 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:26 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:26 volumio volumio[3597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":862,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"192 Kbps","isStreaming":false,"title":"Wham! - Wake Me Up Before You Go-Go","artist":"Made in 80","album":null,"uri":"http://162.19.79.231:8002/","trackType":"231:8002/"} Oct 23 23:05:26 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:26 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:05:26 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:05:26 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:05:26 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:05:26 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:26 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:26 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:26 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:26 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:26 volumio volumio[3597]: info: ------------------------------ 15ms Oct 23 23:05:37 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::stPlaybackTimer Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::serviceStop Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::serviceStop Oct 23 23:05:37 volumio volumio[3597]: info: [1729724737967] ControllerWebradio::stop Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:05:37 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:37 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99570393 Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:05:37 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:37 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:05:37 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:37 volumio volumio[3597]: info: [1729724737979] ControllerWebradio::clearAddPlayTrack Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:05:37 volumio volumio[3597]: info: Oct 23 23:05:37 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:37 volumio volumio[3597]: info: sendMpdCommand stop took 16 milliseconds Oct 23 23:05:37 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:37 volumio volumio[3597]: info: sendMpdCommand stop took 5 milliseconds Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:05:37 volumio volumio[3597]: info: Oct 23 23:05:37 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:37 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:37 volumio volumio[3597]: info: sendMpdCommand status took 4 milliseconds Oct 23 23:05:37 volumio volumio[3597]: info: sendMpdCommand clear took 3 milliseconds Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99570393" Oct 23 23:05:37 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:05:37 volumio volumio[3597]: info: ------------------------------ 7ms Oct 23 23:05:37 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 23 23:05:37 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:37 volumio volumio[3597]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 23 23:05:37 volumio volumio[3597]: info: ------------------------------ 14ms Oct 23 23:05:38 volumio volumio[3597]: info: Oct 23 23:05:38 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:38 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:38 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99570393" took 257 milliseconds Oct 23 23:05:38 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:05:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:05:38 volumio volumio[3597]: info: ------------------------------ 2ms Oct 23 23:05:38 volumio volumio[3597]: info: sendMpdCommand play took 3 milliseconds Oct 23 23:05:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 23:05:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 23:05:38 volumio volumio[3597]: info: Discovery: Getting this device information Oct 23 23:05:38 volumio volumio[3597]: info: CoreCommandRouter::volumioGetState Oct 23 23:05:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 23:05:40 volumio volumio[3597]: info: Oct 23 23:05:40 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:40 volumio volumio[3597]: info: Oct 23 23:05:40 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand status took 3 milliseconds Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand status took 3 milliseconds Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:40 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:40 volumio volumio[3597]: 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":"Radio Magica 87.7 | 80's Hits","album":null,"uri":"https://usa10.fastcast4u.com:1680/","trackType":"com:1680/"} Oct 23 23:05:40 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:05:40 volumio volumio[3597]: info: ------------------------------ 19ms Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 7 milliseconds Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:40 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:40 volumio volumio[3597]: 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":"Radio Magica 87.7 | 80's Hits","album":null,"uri":"https://usa10.fastcast4u.com:1680/","trackType":"com:1680/"} Oct 23 23:05:40 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:05:40 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:40 volumio volumio[3597]: info: ------------------------------ 38ms Oct 23 23:05:40 volumio volumio[3597]: info: Oct 23 23:05:40 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:40 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:40 volumio volumio[3597]: info: Oct 23 23:05:40 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:40 volumio volumio[3597]: info: Oct 23 23:05:40 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:40 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:40 volumio volumio[3597]: info: Oct 23 23:05:40 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:40 volumio volumio[3597]: info: ------------------------------ 4ms Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand status took 4 milliseconds Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:40 volumio volumio[3597]: info: ------------------------------ 4ms Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand status took 4 milliseconds Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:40 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:40 volumio volumio[3597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Main Ingredient - Evening of Love","artist":"Radio Magica 87.7 | 80's Hits","album":null,"uri":"https://usa10.fastcast4u.com:1680/","trackType":"com:1680/"} Oct 23 23:05:40 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:05:40 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:40 volumio volumio[3597]: info: ------------------------------ 19ms Oct 23 23:05:40 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 12 milliseconds Oct 23 23:05:40 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:40 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:40 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:40 volumio volumio[3597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":853,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"The Main Ingredient - Evening of Love","artist":"Radio Magica 87.7 | 80's Hits","album":null,"uri":"https://usa10.fastcast4u.com:1680/","trackType":"com:1680/"} Oct 23 23:05:40 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:05:40 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:40 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:40 volumio volumio[3597]: info: ------------------------------ 39ms Oct 23 23:05:45 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::stPlaybackTimer Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::serviceStop Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::serviceStop Oct 23 23:05:45 volumio volumio[3597]: info: [1729724745852] ControllerWebradio::stop Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:05:45 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:45 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99567588 Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:05:45 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:45 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:05:45 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:45 volumio volumio[3597]: info: [1729724745877] ControllerWebradio::clearAddPlayTrack Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:05:45 volumio volumio[3597]: info: Oct 23 23:05:45 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:45 volumio volumio[3597]: info: sendMpdCommand stop took 45 milliseconds Oct 23 23:05:45 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:45 volumio volumio[3597]: info: sendMpdCommand stop took 21 milliseconds Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:05:45 volumio volumio[3597]: info: Oct 23 23:05:45 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:45 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:45 volumio volumio[3597]: info: sendMpdCommand status took 2 milliseconds Oct 23 23:05:45 volumio volumio[3597]: info: sendMpdCommand clear took 2 milliseconds Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99567588" Oct 23 23:05:45 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:05:45 volumio volumio[3597]: info: ------------------------------ 4ms Oct 23 23:05:45 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 23 23:05:45 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:45 volumio volumio[3597]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Oct 23 23:05:45 volumio volumio[3597]: info: ------------------------------ 9ms Oct 23 23:05:46 volumio volumio[3597]: info: Oct 23 23:05:46 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:46 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:46 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99567588" took 257 milliseconds Oct 23 23:05:46 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:05:46 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:05:46 volumio volumio[3597]: info: ------------------------------ 3ms Oct 23 23:05:46 volumio volumio[3597]: info: sendMpdCommand play took 2 milliseconds Oct 23 23:05:46 volumio volumio[3597]: info: Oct 23 23:05:46 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:46 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:46 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:46 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 23:05:46 volumio volumio[3597]: info: sendMpdCommand status took 5 milliseconds Oct 23 23:05:46 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:46 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:46 volumio volumio[3597]: info: sendMpdCommand clearerror took 2 milliseconds Oct 23 23:05:46 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 23 23:05:46 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:46 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:46 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:46 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:46 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:46 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:46 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:46 volumio volumio[3597]: 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":"stream","artist":"(#1 - 27/999) Classic Hits 24/7 - (70's, 80's and more!)","album":null,"uri":"http://51.161.117.116:5418/stream","trackType":""} Oct 23 23:05:46 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:46 volumio volumio[3597]: info: CoreStateMachine::syncState stateService stop Oct 23 23:05:46 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:05:46 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:46 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:46 volumio volumio[3597]: info: No code Oct 23 23:05:46 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:46 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:46 volumio volumio[3597]: info: ------------------------------ 21ms Oct 23 23:05:55 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:55 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:55 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:05:55 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:55 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:05:55 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:05:55 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:05:55 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99598995 Oct 23 23:05:55 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:05:55 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:05:55 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:05:55 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:05:55 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:05:55 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:05:55 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:55 volumio volumio[3597]: info: [1729724755038] ControllerWebradio::clearAddPlayTrack Oct 23 23:05:55 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:05:55 volumio volumio[3597]: info: sendMpdCommand stop took 2 milliseconds Oct 23 23:05:55 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:05:55 volumio volumio[3597]: info: Oct 23 23:05:55 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:55 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:55 volumio volumio[3597]: info: sendMpdCommand clear took 1 milliseconds Oct 23 23:05:55 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99598995" Oct 23 23:05:55 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:05:55 volumio volumio[3597]: info: ------------------------------ 2ms Oct 23 23:05:55 volumio volumio[3597]: info: Oct 23 23:05:55 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:05:55 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:05:55 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99598995" took 256 milliseconds Oct 23 23:05:55 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:05:55 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:05:55 volumio volumio[3597]: info: ------------------------------ 6ms Oct 23 23:05:55 volumio volumio[3597]: info: sendMpdCommand play took 3 milliseconds Oct 23 23:05:56 volumio volumio[3597]: info: Oct 23 23:05:56 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:05:56 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:05:56 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:05:56 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 23:05:56 volumio volumio[3597]: info: sendMpdCommand status took 9 milliseconds Oct 23 23:05:56 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:05:56 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:05:56 volumio volumio[3597]: info: sendMpdCommand clearerror took 3 milliseconds Oct 23 23:05:56 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 23 23:05:56 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:05:56 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:05:56 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:05:56 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:56 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:05:56 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:56 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:05:56 volumio volumio[3597]: 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 - 15/250) Ritzy RADIO","album":null,"uri":"https://46.105.122.141:9676/","trackType":"141:9676/"} Oct 23 23:05:56 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:05:56 volumio volumio[3597]: info: CoreStateMachine::syncState stateService stop Oct 23 23:05:56 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:05:56 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:56 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:56 volumio volumio[3597]: info: No code Oct 23 23:05:56 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:05:56 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:05:56 volumio volumio[3597]: info: ------------------------------ 36ms Oct 23 23:06:06 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:06 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:06 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:06:06 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:06 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:06:06 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:06:06 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:06 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99221944 Oct 23 23:06:06 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:06:06 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:06 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:06:06 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:06:06 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:06 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:06:06 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:06 volumio volumio[3597]: info: [1729724766034] ControllerWebradio::clearAddPlayTrack Oct 23 23:06:06 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:06:06 volumio volumio[3597]: info: sendMpdCommand stop took 1 milliseconds Oct 23 23:06:06 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:06:06 volumio volumio[3597]: info: Oct 23 23:06:06 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:06 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:06 volumio volumio[3597]: info: sendMpdCommand clear took 1 milliseconds Oct 23 23:06:06 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99221944" Oct 23 23:06:06 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:06:06 volumio volumio[3597]: info: ------------------------------ 2ms Oct 23 23:06:06 volumio volumio[3597]: info: Oct 23 23:06:06 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:06 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:06 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99221944" took 260 milliseconds Oct 23 23:06:06 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:06:06 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:06:06 volumio volumio[3597]: info: ------------------------------ 5ms Oct 23 23:06:06 volumio volumio[3597]: info: sendMpdCommand play took 3 milliseconds Oct 23 23:06:07 volumio volumio[3597]: info: Oct 23 23:06:07 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:06:07 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:06:07 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:06:07 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 23:06:07 volumio volumio[3597]: info: sendMpdCommand status took 4 milliseconds Oct 23 23:06:07 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:06:07 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:06:07 volumio volumio[3597]: info: sendMpdCommand clearerror took 12 milliseconds Oct 23 23:06:07 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 23 23:06:07 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:06:07 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:06:07 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:06:07 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:07 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:06:07 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:07 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:07 volumio volumio[3597]: 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":"113fmawesome80-s-1982","artist":".113FM Awesome 80's - 1982","album":null,"uri":"http://listen.shoutcast.com/113fmawesome80-s-1982","trackType":""} Oct 23 23:06:07 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:06:07 volumio volumio[3597]: info: CoreStateMachine::syncState stateService stop Oct 23 23:06:07 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:06:07 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:07 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:07 volumio volumio[3597]: info: No code Oct 23 23:06:07 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:07 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:07 volumio volumio[3597]: info: ------------------------------ 40ms Oct 23 23:06:08 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 23:06:08 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 23:06:08 volumio volumio[3597]: info: Discovery: Getting this device information Oct 23 23:06:08 volumio volumio[3597]: info: CoreCommandRouter::volumioGetState Oct 23 23:06:08 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 23:06:11 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:11 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:11 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:06:11 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:11 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:06:11 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:06:11 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:11 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99221284 Oct 23 23:06:11 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:06:11 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:11 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:06:11 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:06:11 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:11 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:06:11 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:11 volumio volumio[3597]: info: [1729724771474] ControllerWebradio::clearAddPlayTrack Oct 23 23:06:11 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:06:11 volumio volumio[3597]: info: sendMpdCommand stop took 5 milliseconds Oct 23 23:06:11 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:06:11 volumio volumio[3597]: info: Oct 23 23:06:11 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:11 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:11 volumio volumio[3597]: info: sendMpdCommand clear took 3 milliseconds Oct 23 23:06:11 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99221284" Oct 23 23:06:11 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:06:11 volumio volumio[3597]: info: ------------------------------ 6ms Oct 23 23:06:11 volumio volumio[3597]: info: Oct 23 23:06:11 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:11 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:11 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99221284" took 259 milliseconds Oct 23 23:06:11 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:06:11 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:06:11 volumio volumio[3597]: info: ------------------------------ 6ms Oct 23 23:06:11 volumio volumio[3597]: info: sendMpdCommand play took 6 milliseconds Oct 23 23:06:12 volumio volumio[3597]: info: Oct 23 23:06:12 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:06:12 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:06:12 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:06:12 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 23:06:12 volumio volumio[3597]: info: sendMpdCommand status took 8 milliseconds Oct 23 23:06:12 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:06:12 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:06:12 volumio volumio[3597]: info: sendMpdCommand clearerror took 6 milliseconds Oct 23 23:06:12 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 2 milliseconds Oct 23 23:06:12 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:06:12 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:06:12 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:06:12 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:12 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:06:12 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:12 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:12 volumio volumio[3597]: 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":"m80radiochile","artist":"m80radiochile","album":null,"uri":"http://listen.shoutcast.com/m80radiochile","trackType":""} Oct 23 23:06:12 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:06:12 volumio volumio[3597]: info: CoreStateMachine::syncState stateService stop Oct 23 23:06:12 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:06:12 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:12 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:12 volumio volumio[3597]: info: No code Oct 23 23:06:12 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:12 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:12 volumio volumio[3597]: info: ------------------------------ 45ms Oct 23 23:06:14 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:14 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:14 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:06:14 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:14 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:06:14 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:06:14 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:14 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99231961 Oct 23 23:06:14 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:06:14 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:14 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:06:14 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:06:14 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:14 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:14 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:06:14 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:14 volumio volumio[3597]: info: [1729724774799] ControllerWebradio::clearAddPlayTrack Oct 23 23:06:14 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:06:14 volumio volumio[3597]: info: sendMpdCommand stop took 5 milliseconds Oct 23 23:06:14 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:06:14 volumio volumio[3597]: info: Oct 23 23:06:14 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:14 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:14 volumio volumio[3597]: info: sendMpdCommand clear took 3 milliseconds Oct 23 23:06:14 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99231961" Oct 23 23:06:14 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:06:14 volumio volumio[3597]: info: ------------------------------ 5ms Oct 23 23:06:15 volumio volumio[3597]: info: Oct 23 23:06:15 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:15 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:15 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99231961" took 258 milliseconds Oct 23 23:06:15 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:06:15 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:06:15 volumio volumio[3597]: info: ------------------------------ 6ms Oct 23 23:06:15 volumio volumio[3597]: info: sendMpdCommand play took 4 milliseconds Oct 23 23:06:15 volumio volumio[3597]: info: Oct 23 23:06:15 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:06:15 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:06:15 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:06:15 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clearerror Oct 23 23:06:15 volumio volumio[3597]: info: sendMpdCommand status took 13 milliseconds Oct 23 23:06:15 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:06:15 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:06:15 volumio volumio[3597]: info: sendMpdCommand clearerror took 5 milliseconds Oct 23 23:06:15 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 3 milliseconds Oct 23 23:06:15 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:06:15 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:06:15 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:06:15 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:15 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:06:15 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:15 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:15 volumio volumio[3597]: 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":"djs2rent","artist":"DJs2Rent","album":null,"uri":"http://listen.shoutcast.com/djs2rent","trackType":""} Oct 23 23:06:15 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:06:15 volumio volumio[3597]: info: CoreStateMachine::syncState stateService stop Oct 23 23:06:15 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:06:15 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:15 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:15 volumio volumio[3597]: info: No code Oct 23 23:06:15 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:15 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:15 volumio volumio[3597]: info: ------------------------------ 63ms Oct 23 23:06:27 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 23 23:06:27 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:36 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Oct 23 23:06:36 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:37 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:37 volumio volumio[3597]: info: CoreCommandRouter::volumioReplaceandPlayItems Oct 23 23:06:37 volumio volumio[3597]: info: CoreStateMachine::ClearQueue Oct 23 23:06:37 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:37 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:37 volumio volumio[3597]: info: CorePlayQueue::clearPlayQueue Oct 23 23:06:37 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:37 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::addQueueItems Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::addQueueItems Oct 23 23:06:38 volumio volumio[3597]: info: Preload queue cleared Oct 23 23:06:38 volumio volumio[3597]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1169304 Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::volumioPushQueue Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::saveQueue Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::updateTrackBlock Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::getTrackBlock Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::volumioPlay Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::play index 0 Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::stop Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::play index undefined Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService undefined Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::startPlaybackTimer Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:38 volumio volumio[3597]: info: [1729724798019] ControllerWebradio::clearAddPlayTrack Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand stop Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand stop took 5 milliseconds Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand clear Oct 23 23:06:38 volumio volumio[3597]: info: Oct 23 23:06:38 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:38 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand clear took 2 milliseconds Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1169304" Oct 23 23:06:38 volumio volumio[3597]: error: updateQueue error: null Oct 23 23:06:38 volumio volumio[3597]: info: ------------------------------ 5ms Oct 23 23:06:38 volumio volumio[3597]: info: Oct 23 23:06:38 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:38 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1169304" took 260 milliseconds Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::setConsumeUpdateService mpd Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand play Oct 23 23:06:38 volumio volumio[3597]: info: ------------------------------ 6ms Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand play took 4 milliseconds Oct 23 23:06:38 volumio volumio[3597]: info: Oct 23 23:06:38 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:06:38 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:06:38 volumio volumio[3597]: info: Oct 23 23:06:38 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand status took 4 milliseconds Oct 23 23:06:38 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand status took 4 milliseconds Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:06:38 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:38 volumio volumio[3597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 2/50) E.FM Radio","album":null,"uri":"http://199.180.75.2:9409/stream","trackType":""} Oct 23 23:06:38 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus stop Oct 23 23:06:38 volumio volumio[3597]: info: ------------------------------ 27ms Oct 23 23:06:38 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 13 milliseconds Oct 23 23:06:38 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:06:38 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:38 volumio volumio[3597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"stream","artist":"(#1 - 2/50) E.FM Radio","album":null,"uri":"http://199.180.75.2:9409/stream","trackType":""} Oct 23 23:06:38 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:06:38 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:38 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:38 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:38 volumio volumio[3597]: info: ------------------------------ 52ms Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 23 23:06:38 volumio volumio[3597]: info: Discovery: Getting this device information Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::volumioGetState Oct 23 23:06:38 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 23 23:06:39 volumio volumio[3597]: info: Oct 23 23:06:39 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:39 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:39 volumio volumio[3597]: info: Oct 23 23:06:39 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:06:39 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:06:39 volumio volumio[3597]: info: Oct 23 23:06:39 volumio volumio[3597]: ---------------------------- MPD announces system playlist update Oct 23 23:06:39 volumio volumio[3597]: info: Ignoring MPD Status Update Oct 23 23:06:39 volumio volumio[3597]: info: Oct 23 23:06:39 volumio volumio[3597]: ---------------------------- MPD announces state update: player Oct 23 23:06:39 volumio volumio[3597]: info: ControllerMpd::getState Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand status Oct 23 23:06:39 volumio volumio[3597]: info: ------------------------------ 11ms Oct 23 23:06:39 volumio volumio[3597]: info: sendMpdCommand status took 10 milliseconds Oct 23 23:06:39 volumio volumio[3597]: info: ------------------------------ 8ms Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:06:39 volumio volumio[3597]: info: sendMpdCommand status took 8 milliseconds Oct 23 23:06:39 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 4 milliseconds Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::parseState Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::sendMpdCommand playlistinfo Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:06:39 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:06:39 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:39 volumio volumio[3597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HaroldEstell - EFM DJHossMix","artist":"E.FM Radio","album":null,"uri":"http://199.180.75.2:9409/stream","trackType":""} Oct 23 23:06:39 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:06:39 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:39 volumio volumio[3597]: info: ------------------------------ 54ms Oct 23 23:06:39 volumio volumio[3597]: info: sendMpdCommand playlistinfo took 35 milliseconds Oct 23 23:06:39 volumio volumio[3597]: verbose: ControllerMpd::parseTrackInfo Oct 23 23:06:39 volumio volumio[3597]: info: ControllerMpd::pushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::servicePushState Oct 23 23:06:39 volumio volumio[3597]: info: CorePlayQueue::getTrack 0 Oct 23 23:06:39 volumio volumio[3597]: verbose: STATE SERVICE {"status":"play","position":0,"seek":855,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"128 Kbps","isStreaming":false,"title":"HaroldEstell - EFM DJHossMix","artist":"E.FM Radio","album":null,"uri":"http://199.180.75.2:9409/stream","trackType":""} Oct 23 23:06:39 volumio volumio[3597]: verbose: CURRENT POSITION 0 Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::syncState stateService play Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::syncState currentStatus play Oct 23 23:06:39 volumio volumio[3597]: info: Received an update from plugin. extracting info from payload Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreStateMachine::pushState Oct 23 23:06:39 volumio volumio[3597]: info: CoreCommandRouter::volumioPushState Oct 23 23:06:39 volumio volumio[3597]: info: ------------------------------ 69ms Oct 23 23:06:44 volumio volumio[3597]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 23:06:44 volumio volumio[3597]: Error: connect ECONNREFUSED 93.179.102.140:80 Oct 23 23:06:44 volumio volumio[3597]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Oct 23 23:06:44 volumio volumio[3597]: errno: -111, Oct 23 23:06:44 volumio volumio[3597]: code: 'ECONNREFUSED', Oct 23 23:06:44 volumio volumio[3597]: syscall: 'connect', Oct 23 23:06:44 volumio volumio[3597]: address: '93.179.102.140', Oct 23 23:06:44 volumio volumio[3597]: port: 80 Oct 23 23:06:44 volumio volumio[3597]: } Oct 23 23:06:44 volumio volumio[3597]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 23 23:06:44 volumio sudo[21420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-10-23 23:05 Oct 23 23:06:44 volumio sudo[21420]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="bba9e3185e150dd0995f9a49355b34fc6218d5a2" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8aa57e3ae5b742ea1069404608336a9884ccfb4e" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 17 Sep 2024 05:33:09 PM CEST" VOLUMIO_VERSION="3.757" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="ee834e1c2a28de3c5d8c48611ecf1167"