-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2025-06-29 22:10:10 CST. -- Jun 29 22:09:05 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 29 22:09:05 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 29 22:09:05 volumio volumio[3405]: info: Discovery: Getting this device information Jun 29 22:09:05 volumio volumio[3405]: info: CoreCommandRouter::volumioGetState Jun 29 22:09:05 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 29 22:09:14 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 29 22:09:14 volumio volumio[3405]: info: Preload queue cleared Jun 29 22:09:16 volumio volumio[3405]: info: Preload queue cleared Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::ClearQueue Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::stop Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::stPlaybackTimer Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::updateTrackBlock Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrackBlock Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::serviceStop Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::serviceStop Jun 29 22:09:16 volumio volumio[3405]: info: [1751206156542] ControllerWebradio::stop Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand stop Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::clearPlayQueue Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::saveQueue Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::volumioPushQueue Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::addQueueItems Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::addQueueItems Jun 29 22:09:16 volumio volumio[3405]: info: Preload queue cleared Jun 29 22:09:16 volumio volumio[3405]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99387685 Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::volumioPushQueue Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::saveQueue Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::updateTrackBlock Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrackBlock Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::volumioPlay Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::play index 0 Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::stop Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::play index undefined Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::startPlaybackTimer Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: [1751206156567] ControllerWebradio::clearAddPlayTrack Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand stop Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand stop took 146 milliseconds Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:16 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand stop took 121 milliseconds Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand clear Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:16 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:16 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:16 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand status took 6 milliseconds Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand clear took 5 milliseconds Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand status took 3 milliseconds Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand status took 3 milliseconds Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99387685" Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:16 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jun 29 22:09:16 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:16 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:16 volumio volumio[3405]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 17ms Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 16ms Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:16 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:16 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:16 volumio volumio[3405]: error: updateQueue error: null Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 18ms Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 16 milliseconds Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:16 volumio volumio[3405]: error: ControllerMpd::pushError: TypeError: Cannot read property 'split' of undefined Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 24ms Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=99387685" took 203 milliseconds Jun 29 22:09:16 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 29 22:09:16 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand play Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:16 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 195ms Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 194ms Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:16 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:16 volumio volumio[3405]: info: Jun 29 22:09:16 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:16 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:16 volumio volumio[3405]: info: sendMpdCommand play took 11 milliseconds Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 11ms Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 7ms Jun 29 22:09:16 volumio volumio[3405]: info: ------------------------------ 5ms Jun 29 22:09:18 volumio volumio[3405]: info: Jun 29 22:09:18 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:18 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:18 volumio volumio[3405]: info: Jun 29 22:09:18 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:18 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:18 volumio volumio[3405]: info: Jun 29 22:09:18 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:18 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand status took 4 milliseconds Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand status took 4 milliseconds Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand clearerror Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand status took 13 milliseconds Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand clearerror took 11 milliseconds Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand clearerror took 10 milliseconds Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 4 milliseconds Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:18 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:18 volumio volumio[3405]: 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":"flyingvradiosouthern","artist":"Flying V Radio Southern","album":null,"uri":"http://listen.shoutcast.com/flyingvradiosouthern","trackType":""} Jun 29 22:09:18 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::syncState stateService stop Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus stop Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: No code Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:18 volumio volumio[3405]: 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":"flyingvradiosouthern","artist":"Flying V Radio Southern","album":null,"uri":"http://listen.shoutcast.com/flyingvradiosouthern","trackType":""} Jun 29 22:09:18 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::syncState stateService stop Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus stop Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: No code Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: ------------------------------ 33ms Jun 29 22:09:18 volumio volumio[3405]: info: ------------------------------ 33ms Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand clearerror took 23 milliseconds Jun 29 22:09:18 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 22 milliseconds Jun 29 22:09:18 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:18 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:18 volumio volumio[3405]: 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":"flyingvradiosouthern","artist":"Flying V Radio Southern","album":null,"uri":"http://listen.shoutcast.com/flyingvradiosouthern","trackType":""} Jun 29 22:09:18 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::syncState stateService stop Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus stop Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: No code Jun 29 22:09:18 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:18 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:18 volumio volumio[3405]: info: ------------------------------ 50ms Jun 29 22:09:19 volumio volumio[3405]: info: Preload queue cleared Jun 29 22:09:19 volumio volumio[3405]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::ClearQueue Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::stop Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:19 volumio volumio[3405]: info: CorePlayQueue::clearPlayQueue Jun 29 22:09:19 volumio volumio[3405]: info: CorePlayQueue::saveQueue Jun 29 22:09:19 volumio volumio[3405]: info: CoreCommandRouter::volumioPushQueue Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::addQueueItems Jun 29 22:09:19 volumio volumio[3405]: info: CorePlayQueue::addQueueItems Jun 29 22:09:19 volumio volumio[3405]: info: Preload queue cleared Jun 29 22:09:19 volumio volumio[3405]: info: Adding Item to queue: http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1840508 Jun 29 22:09:19 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Jun 29 22:09:19 volumio volumio[3405]: info: CoreCommandRouter::volumioPushQueue Jun 29 22:09:19 volumio volumio[3405]: info: CorePlayQueue::saveQueue Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::updateTrackBlock Jun 29 22:09:19 volumio volumio[3405]: info: CorePlayQueue::getTrackBlock Jun 29 22:09:19 volumio volumio[3405]: info: CoreCommandRouter::volumioPlay Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::play index 0 Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::stop Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::play index undefined Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 29 22:09:19 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::startPlaybackTimer Jun 29 22:09:19 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:19 volumio volumio[3405]: info: [1751206159591] ControllerWebradio::clearAddPlayTrack Jun 29 22:09:19 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand stop Jun 29 22:09:19 volumio volumio[3405]: info: sendMpdCommand stop took 1 milliseconds Jun 29 22:09:19 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand clear Jun 29 22:09:19 volumio volumio[3405]: info: Jun 29 22:09:19 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:19 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:19 volumio volumio[3405]: info: sendMpdCommand clear took 2 milliseconds Jun 29 22:09:19 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1840508" Jun 29 22:09:19 volumio volumio[3405]: info: Jun 29 22:09:19 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:19 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:19 volumio volumio[3405]: info: Jun 29 22:09:19 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:19 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:19 volumio volumio[3405]: error: updateQueue error: null Jun 29 22:09:19 volumio volumio[3405]: info: ------------------------------ 3ms Jun 29 22:09:19 volumio volumio[3405]: info: Jun 29 22:09:19 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:19 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:19 volumio volumio[3405]: info: sendMpdCommand load "http://yp.shoutcast.com/sbin/tunein-station.m3u?id=1840508" took 204 milliseconds Jun 29 22:09:19 volumio volumio[3405]: info: CoreStateMachine::setConsumeUpdateService mpd Jun 29 22:09:19 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand play Jun 29 22:09:19 volumio volumio[3405]: info: ------------------------------ 204ms Jun 29 22:09:19 volumio volumio[3405]: info: ------------------------------ 204ms Jun 29 22:09:19 volumio volumio[3405]: info: Jun 29 22:09:19 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:19 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:19 volumio volumio[3405]: info: Jun 29 22:09:19 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:19 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:19 volumio volumio[3405]: info: ------------------------------ 5ms Jun 29 22:09:19 volumio volumio[3405]: info: sendMpdCommand play took 4 milliseconds Jun 29 22:09:19 volumio volumio[3405]: info: ------------------------------ 2ms Jun 29 22:09:19 volumio volumio[3405]: info: ------------------------------ 2ms Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:21 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand status took 278 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand status took 280 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand status took 278 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 7ms Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand status took 5 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 5 milliseconds Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:21 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:21 volumio volumio[3405]: 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":"90 Kbps","isStreaming":false,"title":"PUNTACANA 99.1 FM","artist":"PUNTA CANA 99.1 FM","album":null,"uri":"http://s3.voscast.com:9442","trackType":"com:9442"} Jun 29 22:09:21 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState stateService play Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus stop Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 293ms Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:21 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces system playlist update Jun 29 22:09:21 volumio volumio[3405]: info: Ignoring MPD Status Update Jun 29 22:09:21 volumio volumio[3405]: info: Jun 29 22:09:21 volumio volumio[3405]: ---------------------------- MPD announces state update: player Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::getState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand status Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 15 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 14 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 10ms Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand status took 9 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 7ms Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand status took 6 milliseconds Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseState Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:21 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:21 volumio volumio[3405]: verbose: STATE SERVICE {"status":"play","position":0,"seek":398,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"90 Kbps","isStreaming":false,"title":"PUNTACANA 99.1 FM","artist":"PUNTA CANA 99.1 FM","album":null,"uri":"http://s3.voscast.com:9442","trackType":"com:9442"} Jun 29 22:09:21 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState stateService play Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus play Jun 29 22:09:21 volumio volumio[3405]: info: Received an update from plugin. extracting info from payload Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:21 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:21 volumio volumio[3405]: verbose: STATE SERVICE {"status":"play","position":0,"seek":602,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"90 Kbps","isStreaming":false,"title":"PUNTACANA 99.1 FM","artist":"PUNTA CANA 99.1 FM","album":null,"uri":"http://s3.voscast.com:9442","trackType":"com:9442"} Jun 29 22:09:21 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState stateService play Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus play Jun 29 22:09:21 volumio volumio[3405]: info: Received an update from plugin. extracting info from payload Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:21 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:21 volumio volumio[3405]: verbose: STATE SERVICE {"status":"play","position":0,"seek":728,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"90 Kbps","isStreaming":false,"title":"PUNTACANA 99.1 FM","artist":"PUNTA CANA 99.1 FM","album":null,"uri":"http://s3.voscast.com:9442","trackType":"com:9442"} Jun 29 22:09:21 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState stateService play Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus play Jun 29 22:09:21 volumio volumio[3405]: info: Received an update from plugin. extracting info from payload Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 338ms Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 336ms Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 64ms Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 41 milliseconds Jun 29 22:09:21 volumio volumio[3405]: info: sendMpdCommand playlistinfo took 41 milliseconds Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:21 volumio volumio[3405]: verbose: ControllerMpd::parseTrackInfo Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:21 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:21 volumio volumio[3405]: verbose: STATE SERVICE {"status":"play","position":0,"seek":979,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"90 Kbps","isStreaming":false,"title":"PUNTACANA 99.1 FM","artist":"PUNTA CANA 99.1 FM","album":null,"uri":"http://s3.voscast.com:9442","trackType":"com:9442"} Jun 29 22:09:21 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState stateService play Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus play Jun 29 22:09:21 volumio volumio[3405]: info: Received an update from plugin. extracting info from payload Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: ControllerMpd::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::servicePushState Jun 29 22:09:21 volumio volumio[3405]: info: CorePlayQueue::getTrack 0 Jun 29 22:09:21 volumio volumio[3405]: verbose: STATE SERVICE {"status":"play","position":0,"seek":979,"duration":0,"samplerate":44.1,"bitdepth":"32 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"90 Kbps","isStreaming":false,"title":"PUNTACANA 99.1 FM","artist":"PUNTA CANA 99.1 FM","album":null,"uri":"http://s3.voscast.com:9442","trackType":"com:9442"} Jun 29 22:09:21 volumio volumio[3405]: verbose: CURRENT POSITION 0 Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState stateService play Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::syncState currentStatus play Jun 29 22:09:21 volumio volumio[3405]: info: Received an update from plugin. extracting info from payload Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::executeOnPlugin: albumart , getAlbumArt Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreStateMachine::pushState Jun 29 22:09:21 volumio volumio[3405]: info: CoreCommandRouter::volumioPushState Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 69ms Jun 29 22:09:21 volumio volumio[3405]: info: ------------------------------ 67ms Jun 29 22:10:10 volumio volumio[3405]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 22:10:10 volumio volumio[3405]: Error: connect ETIMEDOUT 162.125.1.8:80 Jun 29 22:10:10 volumio volumio[3405]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 29 22:10:10 volumio volumio[3405]: errno: -110, Jun 29 22:10:10 volumio volumio[3405]: code: 'ETIMEDOUT', Jun 29 22:10:10 volumio volumio[3405]: syscall: 'connect', Jun 29 22:10:10 volumio volumio[3405]: address: '162.125.1.8', Jun 29 22:10:10 volumio volumio[3405]: port: 80 Jun 29 22:10:10 volumio volumio[3405]: } Jun 29 22:10:10 volumio volumio[3405]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 29 22:10:10 volumio sudo[18660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-29 22:09 Jun 29 22:10:10 volumio sudo[18660]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="a01a833dd28483f88cb390596f5090b7187992af" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 12:15:38 PM CET" VOLUMIO_VERSION="3.795" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9e0e048b157c8fb0f19240808f3da58b"