-- Logs begin at Thu 2019-02-14 18:11:58 CST, end at Sun 2025-04-20 20:54:46 CST. -- Apr 20 20:53:00 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Green%20Day/21st%20Century%20Breakdown/f5428073-96d5-46ca-a7ae-c702c9d56177.jpg' Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 20 20:53:00 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:53:00 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:00 volumio volumio[14878]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8 Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:00 volumio volumio[14878]: info: [1745153580567] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:00 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Angela%20Ammons/Angela%20Ammons/d452e69f-ea0d-49ad-82a0-77b296fd0c9a.jpg' Apr 20 20:53:00 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:53:00 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:00 volumio volumio[14878]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8 Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:53:00 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:00 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:00 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:00 volumio volumio[14878]: info: [1745153580823] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:01 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Alsou/Alsou/9a4a6a85-94bf-43f7-873d-936b3fa74423.png' Apr 20 20:53:02 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Aqua/Aquarium/51d1c166-38bf-4441-9454-a483ddb1dbcd.png' Apr 20 20:53:02 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:02 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:02 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:53:02 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:53:02 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:53:02 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:02 volumio volumio[14878]: info: Adding Item to queue: http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8 Apr 20 20:53:02 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:53:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:02 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:53:02 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:53:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:02 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:02 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:02 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:02 volumio volumio[14878]: info: [1745153582380] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:02 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:03 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Emilia/Big%20Big%20World/efa6222e-968c-486c-8ce1-536838c2360b.jpg' Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::volumioGetBrowseSources Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 20 20:53:04 volumio volumio[14878]: error: MyVolumio Plugin failed to authenticate in a timely fashion Apr 20 20:53:04 volumio volumio[14878]: info: Completed starting MyVolumio Plugin Apr 20 20:53:04 volumio volumio[14878]: [Metrics] CommandRouter: 37s 530.49ms Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::volumiosetStartupVolume Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::Close All Modals sent Apr 20 20:53:04 volumio volumio[14878]: info: CoreCommandRouter::Close All Modals sent Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand stop took 4843 milliseconds Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:53:05 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand stop took 4591 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand stop took 3034 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand clear took 4 milliseconds Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:53:05 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand status took 12 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand status took 11 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 12ms Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand clear took 11 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand clear took 11 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" took 11 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand status took 10 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 10ms Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:53:05 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:05 volumio volumio[14878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:53:05 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::syncState stateService stop Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: No code Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:05 volumio volumio[14878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:53:05 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::syncState stateService stop Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: No code Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:05 volumio volumio[14878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:53:05 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::syncState stateService stop Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: No code Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 63ms Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 63ms Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 59ms Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 60ms Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 61ms Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 60ms Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" took 51 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand add "http://as-hls-ww-live.akamaized.net/pool_01505109/live/ww/bbc_radio_one/bbc_radio_one.isml/bbc_radio_one-audio%3d128000.norewind.m3u8" took 51 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand play took 50 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 4ms Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 4ms Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:53:05 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:53:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: Apr 20 20:53:05 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:05 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 12ms Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 11ms Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand play took 9 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: sendMpdCommand play took 9 milliseconds Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:53:05 volumio volumio[14878]: info: ------------------------------ 2ms Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Apr 20 20:53:05 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Apr 20 20:53:10 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Ronan%20Hardiman/Anthem/77496818-5d6d-4df5-bf01-0b86db6a94db.jpg' Apr 20 20:53:10 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Deep%20Forest/Boheme/9f4c242d-b720-4af8-aafb-67c143053d3c.jpg' Apr 20 20:53:11 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dan%20ar%20Braz/Celtiques/d47d5b1b-eb44-443b-a540-c02c229c7116.jpg' Apr 20 20:53:11 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Shayne%20Ward/Breathless/f132b01d-7bf6-455c-b983-5e4715c0b0b8.jpg' Apr 20 20:53:11 volumio volumio[14878]: info: BOOT COMPLETED Apr 20 20:53:12 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:12 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:12 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:53:12 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:12 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:53:12 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:53:12 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:12 volumio volumio[14878]: info: Adding Item to queue: https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U Apr 20 20:53:12 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:53:12 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:12 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:53:12 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:53:12 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:12 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:12 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:12 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:12 volumio volumio[14878]: info: [1745153592320] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:12 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:14 volumio volumio[14878]: info: sendMpdCommand stop took 2048 milliseconds Apr 20 20:53:14 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:53:14 volumio volumio[14878]: info: Apr 20 20:53:14 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:53:14 volumio volumio[14878]: info: Apr 20 20:53:14 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:14 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:14 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:53:14 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:53:14 volumio volumio[14878]: info: sendMpdCommand clear took 3 milliseconds Apr 20 20:53:14 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:53:14 volumio volumio[14878]: info: Apr 20 20:53:14 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:53:14 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:53:14 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:53:14 volumio volumio[14878]: info: Apr 20 20:53:14 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:53:14 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:53:14 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:53:14 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:14 volumio volumio[14878]: info: sendMpdCommand status took 5 milliseconds Apr 20 20:53:14 volumio volumio[14878]: info: ------------------------------ 7ms Apr 20 20:53:14 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:53:14 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:53:14 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:53:14 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:14 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:14 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:53:14 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:14 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:14 volumio volumio[14878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 20 20:53:14 volumio volumio[14878]: info: ------------------------------ 14ms Apr 20 20:53:14 volumio volumio[14878]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 20:53:14 volumio volumio[14878]: info: Retrying Login Due to Network Error Apr 20 20:53:20 volumio volumio-remote-updater[633]: No test mode Apr 20 20:53:20 volumio volumio-remote-updater[633]: No alpha test mode Apr 20 20:53:20 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Apr 20 20:53:21 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Carrie%20Underwood/Carnival%20Ride/55a2d305-0f3c-472c-8d22-1a7d7ed431ce.png' Apr 20 20:53:21 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yohanna/Butterflies%20and%20Elvis/3b6b238a-2e1d-4120-8cf6-d8dbff042a25.jpg' Apr 20 20:53:22 volumio volumio[14878]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Apr 20 20:53:22 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Apr 20 20:53:23 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:23 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:23 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:23 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:23 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:23 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:23 volumio volumio[14878]: info: [1745153603537] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:23 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:24 volumio volumio[14878]: verbose: New Socket.io Connection to 192.168.0.105 from 192.168.0.113 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:137.0) Gecko/20100101 Firefox/137.0 Engine version: 3 Transport: polling Total Clients: 5 Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Apr 20 20:53:24 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sweetbox/Classified/3fea1976-b5d8-4a3a-9033-e320555431e8.jpg' Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::volumioGetVisibleSources Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::volumioGetState Apr 20 20:53:24 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::volumioGetState Apr 20 20:53:24 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Apr 20 20:53:24 volumio volumio[14878]: info: Received Get System Info Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 20 20:53:24 volumio volumio[14878]: info: Discovery: Getting this device information Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::volumioGetState Apr 20 20:53:24 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 20 20:53:24 volumio volumio[14878]: info: CoreCommandRouter::volumioGetState Apr 20 20:53:24 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:24 volumio volumio[14878]: info: Listing playlists Apr 20 20:53:24 volumio volumio[14878]: info: MyVolumio login type: Token Apr 20 20:53:25 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Apr 20 20:53:26 volumio volumio[14878]: info: CoreCommandRouter::volumioGetState Apr 20 20:53:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:28 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/Ethnicity/a31e8856-5f1b-43e4-a32b-27e36eea3bca.jpg' Apr 20 20:53:30 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Shania%20Twain/Come%20On%20Over/e76e31ab-35bb-481d-b1f1-a16f9c9f21b7.png' Apr 20 20:53:31 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Lisa%20Miskovsky/Fallingwater/af61fe7c-6c99-4d57-bbed-3bba20daa969.jpg' Apr 20 20:53:31 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Air%20Supply/Forever%20Love%20-%2036%20Greatest%20Hits%20(1980-2001)%20%5BDisc%202%5D/8ec1bb9e-ff65-4d5b-96bc-6862b1386f8c.jpg' Apr 20 20:53:32 volumio volumio[14878]: info: VolumeController::SetAlsaVolume52 Apr 20 20:53:32 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:32 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:32 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:53:32 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:33 volumio volumio[14878]: info: VolumeController::SetAlsaVolume96 Apr 20 20:53:33 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:33 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:33 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:53:33 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:34 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:53:34 volumio volumio[14878]: info: sendMpdCommand status took 20435 milliseconds Apr 20 20:53:34 volumio volumio[14878]: info: sendMpdCommand status took 20435 milliseconds Apr 20 20:53:34 volumio volumio[14878]: info: sendMpdCommand stop took 11271 milliseconds Apr 20 20:53:34 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:53:34 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:53:34 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:53:34 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:53:34 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:34 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:34 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:53:34 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:34 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:34 volumio volumio[14878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 20 20:53:34 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:53:34 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:53:34 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:34 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:34 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:34 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:34 volumio volumio[14878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 20 20:53:34 volumio volumio[14878]: info: ------------------------------ 20451ms Apr 20 20:53:34 volumio volumio[14878]: info: ------------------------------ 20449ms Apr 20 20:53:34 volumio volumio[14878]: info: Apr 20 20:53:34 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:34 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:34 volumio volumio[14878]: info: Apr 20 20:53:34 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:34 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:34 volumio volumio[14878]: info: Apr 20 20:53:34 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:34 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:34 volumio volumio[14878]: info: Apr 20 20:53:34 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:34 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:34 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:34 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:34 volumio volumio[14878]: info: sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" took 20 milliseconds Apr 20 20:53:34 volumio volumio[14878]: info: sendMpdCommand clear took 18 milliseconds Apr 20 20:53:34 volumio volumio[14878]: info: ------------------------------ 4ms Apr 20 20:53:34 volumio volumio[14878]: info: ------------------------------ 3ms Apr 20 20:53:34 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:53:34 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:53:34 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:53:34 volumio volumio[14878]: info: Apr 20 20:53:34 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:34 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:34 volumio volumio[14878]: info: Apr 20 20:53:34 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:34 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:34 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:34 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:34 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:53:34 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:53:34 volumio volumio[14878]: info: sendMpdCommand play took 6 milliseconds Apr 20 20:53:35 volumio volumio[14878]: info: VolumeController::SetAlsaVolume71 Apr 20 20:53:35 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:53:35 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:53:35 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:53:35 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Shivaree/Goodnight%20Moon%20(Single)/e78154ce-c84e-4283-bbaf-76bc60adcad7.jpg' Apr 20 20:53:36 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Isgaard/Golden%20Key%20(Limited%20Edition)/137bae44-53d9-4afb-b5f0-c4bbd30145cb.jpg' Apr 20 20:53:38 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Hilary%20Duff/Hilary%20Duff/4fdfed3b-5796-401c-89f9-3fbecb1f45ae.png' Apr 20 20:53:38 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sarah%20Connor/Green%20Eyed%20Soul/5219b5bb-165d-45cc-a175-8d5b1e1f2b6d.png' Apr 20 20:53:40 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:40 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:40 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:40 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:40 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:40 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:40 volumio volumio[14878]: info: [1745153620282] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:40 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:40 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jennifer%20Lopez/Hit%20Collection/0da07634-f6ac-4905-bf72-bc082f287b1e.jpg' Apr 20 20:53:42 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Yanni/If%20I%20Could%20Tell%20You/c70443b2-7b51-4bce-86c7-7882830b2743.jpg' Apr 20 20:53:44 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Delta%20Goodrem/Innocent%20Eyes/2987c7c9-2db2-4844-8006-2717403d0564.png' Apr 20 20:53:44 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:44 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:44 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:44 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:44 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:44 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:44 volumio volumio[14878]: info: [1745153624544] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:44 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:45 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Jessica%20Simpson/Irresistible/4f86a7e6-18b0-418a-b65e-5ad87f3343e0.jpg' Apr 20 20:53:48 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mehdi/Instrumental%20Evolution%20(vol.6)/5c0e48ab-4cd6-47c1-8dfe-1c9a63a6848e.jpg' Apr 20 20:53:48 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Inna/Hot/0ce4a0a9-7aaa-4bcd-a1cb-3a968ea68075.jpg' Apr 20 20:53:49 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:49 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:53:49 volumio volumio[14878]: info: ------------------------------ 14245ms Apr 20 20:53:49 volumio volumio[14878]: info: ------------------------------ 14244ms Apr 20 20:53:49 volumio volumio[14878]: info: sendMpdCommand stop took 8792 milliseconds Apr 20 20:53:49 volumio volumio[14878]: info: sendMpdCommand stop took 4531 milliseconds Apr 20 20:53:49 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:53:49 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:53:49 volumio volumio[14878]: info: Apr 20 20:53:49 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:49 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:49 volumio volumio[14878]: info: Apr 20 20:53:49 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:49 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:49 volumio volumio[14878]: info: Apr 20 20:53:49 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:49 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:49 volumio volumio[14878]: info: sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" took 3 milliseconds Apr 20 20:53:49 volumio volumio[14878]: info: sendMpdCommand clear took 2 milliseconds Apr 20 20:53:49 volumio volumio[14878]: info: sendMpdCommand clear took 3 milliseconds Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:53:49 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:53:49 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:53:49 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:53:49 volumio volumio[14878]: info: Apr 20 20:53:49 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:49 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:49 volumio volumio[14878]: info: Apr 20 20:53:49 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:53:49 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:53:49 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:49 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:49 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:53:49 volumio volumio[14878]: info: ------------------------------ 6ms Apr 20 20:53:49 volumio volumio[14878]: info: ------------------------------ 6ms Apr 20 20:53:49 volumio volumio[14878]: info: ------------------------------ 6ms Apr 20 20:53:49 volumio volumio[14878]: info: sendMpdCommand play took 5 milliseconds Apr 20 20:53:49 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:49 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:49 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:53:49 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:49 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:53:49 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:53:49 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:49 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:53:49 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:53:49 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:49 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:53:49 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:53:49 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:49 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:49 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:49 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:49 volumio volumio[14878]: info: [1745153629633] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:49 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:50 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:50 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:50 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:53:50 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:50 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:53:50 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:53:50 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:50 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:53:50 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:53:50 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:50 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:53:50 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:53:50 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:50 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:50 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:50 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:50 volumio volumio[14878]: info: [1745153630971] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:50 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:51 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:51 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:51 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:53:51 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:51 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:53:51 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:53:51 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:53:51 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:53:51 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:53:51 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:53:51 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:53:51 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:53:51 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:53:51 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:51 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:53:51 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:53:51 volumio volumio[14878]: info: [1745153631181] ControllerWebradio::clearAddPlayTrack Apr 20 20:53:51 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:53:53 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Sarah%20Connor/Key%20To%20my%20Soul/1cea3f98-6d49-4139-8839-df6ac0fb5aae.jpg' Apr 20 20:53:53 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Dido/Life%20For%20Rent/b5f4371f-0da8-44a0-bc7e-6bb38c53f540.png' Apr 20 20:53:54 volumio volumio[14878]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 20:53:54 volumio volumio[14878]: info: Retrying Login Due to Network Error Apr 20 20:53:55 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:53:58 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Atomic%20Kitten/Ladies%20Night/9495fd45-e20d-4ce3-bf30-ea089c962d6a.png' Apr 20 20:53:58 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Boys%20Like%20Girls/Love%20Drunk/ab24b69d-2364-4777-81af-5187ff0933f9.png' Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 11728ms Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 11726ms Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand stop took 11172 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand stop took 9838 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand stop took 9628 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" took 5673 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 5ms Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 10ms Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand add "https://stream-176.zeno.fm/vmnqf6bplmfvv?zt=eyJhbGciOiJIUzI1NiJ9.eyJzdHJlYW0iOiJ2bW5xZjZicGxtZnZ2IiwiaG9zdCI6InN0cmVhbS0xNzYuemVuby5mbSIsInRtIjpmYWxzZSwicnR0bCI6NSwianRpIjoiNVhwUzZRdGhSYTZUMFhSSzBxR2xFdyIsImlhdCI6MTc0NTExNzUwMSwiZXhwIjoxNzQ1MTE3NTYxfQ.Nmenr-6v5MFJv85iBGxO4rg_JGG8G-lA0RD-WG6Rp6U" took 7 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand clear took 6 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand clear took 6 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand clear took 6 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand play took 6 milliseconds Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 5ms Apr 20 20:54:00 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:00 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: info: Apr 20 20:54:00 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:00 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:54:00 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:54:00 volumio volumio[14878]: info: sendMpdCommand play took 5 milliseconds Apr 20 20:54:02 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:02 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:02 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:02 volumio volumio[14878]: info: [1745153642740] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:02 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:02 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:02 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:02 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:02 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:02 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:02 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:02 volumio volumio[14878]: info: [1745153642890] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:02 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:02 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Brad%20Paisley/Mud%20On%20The%20Tires/79d4c291-0803-44f5-ae51-df9469e0eea5.jpg' Apr 20 20:54:03 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Mark%20Medlock/Mr.%20Lonely/73349743-42cb-49a2-9797-09d4ae15ce5a.jpg' Apr 20 20:54:04 volumio volumio[14878]: info: MyVolumio login type: Token Apr 20 20:54:05 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:07 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:07 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:07 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:07 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:07 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:07 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:07 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:07 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:07 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:07 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:07 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:07 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:07 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:07 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:07 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:07 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:07 volumio volumio[14878]: info: [1745153647610] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:07 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:08 volumio volumio[14878]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/Paolo%20Meneguzzi/Musica/e00e46a4-fd66-4cb8-abed-c84c919599f8.png' Apr 20 20:54:09 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:09 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:09 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:09 volumio volumio[14878]: info: [1745153649635] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:09 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:09 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:09 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:09 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:09 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:09 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:09 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:09 volumio volumio[14878]: info: [1745153649811] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:09 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:11 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:11 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 10474ms Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 10473ms Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand stop took 8552 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand stop took 8404 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 5902 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand stop took 3683 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand stop took 1659 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand stop took 1483 milliseconds Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:11 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:11 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 7 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 7 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 9ms Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand clear took 6 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand clear took 6 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand play took 5 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand clear took 5 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand clear took 5 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand clear took 5 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 5ms Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 4ms Apr 20 20:54:11 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:11 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:11 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: info: Apr 20 20:54:11 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:11 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:11 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:11 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:11 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 8ms Apr 20 20:54:11 volumio volumio[14878]: info: ------------------------------ 7ms Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand play took 5 milliseconds Apr 20 20:54:11 volumio volumio[14878]: info: sendMpdCommand play took 6 milliseconds Apr 20 20:54:13 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:17 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:17 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:17 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:17 volumio volumio[14878]: info: [1745153657218] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:17 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:17 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:17 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:17 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:17 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:17 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:17 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:17 volumio volumio[14878]: info: [1745153657395] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:17 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 8345ms Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 8344ms Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 6042 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand stop took 2432 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand stop took 2255 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 9 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 9 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 10 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 10 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 11ms Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand play took 8 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand clear took 8 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: sendMpdCommand clear took 8 milliseconds Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 7ms Apr 20 20:54:19 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 6ms Apr 20 20:54:19 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:19 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:19 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:19 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:19 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:19 volumio volumio[14878]: info: Apr 20 20:54:19 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:19 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:19 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 11ms Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 11ms Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 10ms Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 11ms Apr 20 20:54:19 volumio volumio[14878]: info: ------------------------------ 10ms Apr 20 20:54:20 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:20 volumio volumio[14878]: info: CoreCommandRouter::volumioReplaceandPlayItems Apr 20 20:54:20 volumio volumio[14878]: info: CoreStateMachine::ClearQueue Apr 20 20:54:20 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:20 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:20 volumio volumio[14878]: info: CorePlayQueue::clearPlayQueue Apr 20 20:54:20 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:20 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::addQueueItems Apr 20 20:54:21 volumio volumio[14878]: info: CorePlayQueue::addQueueItems Apr 20 20:54:21 volumio volumio[14878]: info: Preload queue cleared Apr 20 20:54:21 volumio volumio[14878]: info: Adding Item to queue: http://stream.live.vc.bbcmedia.co.uk/bbc_world_service Apr 20 20:54:21 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Apr 20 20:54:21 volumio volumio[14878]: info: CoreCommandRouter::volumioPushQueue Apr 20 20:54:21 volumio volumio[14878]: info: CorePlayQueue::saveQueue Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::updateTrackBlock Apr 20 20:54:21 volumio volumio[14878]: info: CorePlayQueue::getTrackBlock Apr 20 20:54:21 volumio volumio[14878]: info: CoreCommandRouter::volumioPlay Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::play index 0 Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::stop Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::play index undefined Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService undefined Apr 20 20:54:21 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:21 volumio volumio[14878]: info: CoreStateMachine::startPlaybackTimer Apr 20 20:54:21 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:21 volumio volumio[14878]: info: [1745153661007] ControllerWebradio::clearAddPlayTrack Apr 20 20:54:21 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand stop Apr 20 20:54:23 volumio volumio[14878]: info: Apr 20 20:54:23 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:23 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:23 volumio volumio[14878]: info: Apr 20 20:54:23 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:23 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:23 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand status took 3723 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand play took 3722 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand play took 3721 milliseconds Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 3720ms Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand status took 3718 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand stop took 2377 milliseconds Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand clear Apr 20 20:54:23 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:23 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:23 volumio volumio[14878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 20 20:54:23 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:23 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:23 volumio volumio[14878]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received mpd Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 3740ms Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 3734ms Apr 20 20:54:23 volumio volumio[14878]: info: Apr 20 20:54:23 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:23 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:23 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:23 volumio volumio[14878]: info: Apr 20 20:54:23 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:23 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:23 volumio volumio[14878]: info: Apr 20 20:54:23 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:23 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:23 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 26ms Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand status took 25 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 19 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 18 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand clear took 17 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 4ms Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:23 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand load "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:23 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:23 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:23 volumio volumio[14878]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Apr 20 20:54:23 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::syncState stateService stop Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:23 volumio volumio[14878]: info: No code Apr 20 20:54:23 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:23 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 45ms Apr 20 20:54:23 volumio volumio[14878]: info: Apr 20 20:54:23 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:23 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:23 volumio volumio[14878]: info: Apr 20 20:54:23 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:23 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:23 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:23 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 24ms Apr 20 20:54:23 volumio volumio[14878]: info: ------------------------------ 24ms Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand play took 21 milliseconds Apr 20 20:54:23 volumio volumio[14878]: info: sendMpdCommand play took 22 milliseconds Apr 20 20:54:24 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:24 volumio volumio[14878]: error: updateQueue error: null Apr 20 20:54:24 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" Apr 20 20:54:24 volumio volumio[14878]: info: ------------------------------ 1335ms Apr 20 20:54:24 volumio volumio[14878]: info: ------------------------------ 1331ms Apr 20 20:54:24 volumio volumio[14878]: info: Apr 20 20:54:24 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:24 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:24 volumio volumio[14878]: info: sendMpdCommand add "http://stream.live.vc.bbcmedia.co.uk/bbc_world_service" took 2 milliseconds Apr 20 20:54:24 volumio volumio[14878]: info: CoreStateMachine::setConsumeUpdateService mpd Apr 20 20:54:24 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand play Apr 20 20:54:24 volumio volumio[14878]: info: Apr 20 20:54:24 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:24 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:24 volumio volumio[14878]: info: Apr 20 20:54:24 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:24 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:24 volumio volumio[14878]: info: ------------------------------ 6ms Apr 20 20:54:24 volumio volumio[14878]: info: sendMpdCommand play took 5 milliseconds Apr 20 20:54:24 volumio volumio[14878]: info: ------------------------------ 3ms Apr 20 20:54:24 volumio volumio[14878]: info: ------------------------------ 2ms Apr 20 20:54:24 volumio volumio[14878]: info: Apr 20 20:54:24 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:24 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:24 volumio volumio[14878]: info: ------------------------------ 2ms Apr 20 20:54:26 volumio volumio[14878]: info: Apr 20 20:54:26 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:26 volumio volumio[14878]: info: Apr 20 20:54:26 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:26 volumio volumio[14878]: info: Apr 20 20:54:26 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:26 volumio volumio[14878]: info: Apr 20 20:54:26 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand status took 5 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand status took 3 milliseconds Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:26 volumio volumio[14878]: info: Apr 20 20:54:26 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:26 volumio volumio[14878]: info: Apr 20 20:54:26 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand status took 7 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand status took 7 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 6 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand status took 3 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_world_service","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:26 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus stop Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_world_service","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:26 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:26 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: ------------------------------ 29ms Apr 20 20:54:26 volumio volumio[14878]: info: ------------------------------ 34ms Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 22 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 23 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 20 20:54:26 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 24 milliseconds Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:26 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_world_service","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:26 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:26 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_world_service","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:26 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:26 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_world_service","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:26 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:26 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"bbc_world_service","artist":null,"album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:26 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:26 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:26 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:26 volumio volumio[14878]: info: ------------------------------ 71ms Apr 20 20:54:26 volumio volumio[14878]: info: ------------------------------ 70ms Apr 20 20:54:26 volumio volumio[14878]: info: ------------------------------ 68ms Apr 20 20:54:26 volumio volumio[14878]: info: ------------------------------ 66ms Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioGetState Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:27 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:27 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:27 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 5ms Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand status took 4 milliseconds Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 4ms Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand status took 3 milliseconds Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 2ms Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 1 milliseconds Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 2 milliseconds Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:27 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:27 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC Radio","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:27 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:27 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:27 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:27 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC Radio","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:27 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:27 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:27 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:27 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":966,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC Radio","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:27 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:27 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 37ms Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 36ms Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 36ms Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:27 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:27 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 4ms Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand status took 3 milliseconds Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 2ms Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand status took 1 milliseconds Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces system playlist update Apr 20 20:54:27 volumio volumio[14878]: info: Ignoring MPD Status Update Apr 20 20:54:27 volumio volumio[14878]: info: Apr 20 20:54:27 volumio volumio[14878]: ---------------------------- MPD announces state update: player Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::getState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand status Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 3 milliseconds Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 2ms Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand status took 2 milliseconds Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseState Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::sendMpdCommand playlistinfo Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:27 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:27 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1217,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC World Service Online","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:27 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:27 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:27 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:27 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1217,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC World Service Online","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:27 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:27 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 31ms Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 33ms Apr 20 20:54:27 volumio volumio[14878]: info: sendMpdCommand playlistinfo took 26 milliseconds Apr 20 20:54:27 volumio volumio[14878]: verbose: ControllerMpd::parseTrackInfo Apr 20 20:54:27 volumio volumio[14878]: info: ControllerMpd::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::servicePushState Apr 20 20:54:27 volumio volumio[14878]: info: CorePlayQueue::getTrack 0 Apr 20 20:54:27 volumio volumio[14878]: verbose: STATE SERVICE {"status":"play","position":0,"seek":1217,"duration":0,"samplerate":"24 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":"56 Kbps","isStreaming":false,"title":"BBC World Service Online","artist":"BBC Radio","album":null,"uri":"http://stream.live.vc.bbcmedia.co.uk/bbc_world_service","trackType":""} Apr 20 20:54:27 volumio volumio[14878]: verbose: CURRENT POSITION 0 Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState stateService play Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::syncState currentStatus play Apr 20 20:54:27 volumio volumio[14878]: info: Received an update from plugin. extracting info from payload Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:27 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:27 volumio volumio[14878]: info: ------------------------------ 42ms Apr 20 20:54:34 volumio volumio[14878]: info: VolumeController::SetAlsaVolume97 Apr 20 20:54:34 volumio volumio[14878]: info: CoreStateMachine::pushState Apr 20 20:54:34 volumio volumio[14878]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 20 20:54:34 volumio volumio[14878]: info: CoreCommandRouter::volumioPushState Apr 20 20:54:34 volumio volumio[14878]: error: MyVolumio got a network error: A network error (such as timeout, interrupted connection or unreachable host) has occurred. Apr 20 20:54:34 volumio volumio[14878]: info: Retrying Login Due to Network Error Apr 20 20:54:44 volumio volumio[14878]: info: MyVolumio login type: Token Apr 20 20:54:45 volumio volumio[14878]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 20:54:45 volumio volumio[14878]: Error: connect ETIMEDOUT 108.160.166.61:443 Apr 20 20:54:45 volumio volumio[14878]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1146:16) { Apr 20 20:54:45 volumio volumio[14878]: errno: -110, Apr 20 20:54:45 volumio volumio[14878]: code: 'ETIMEDOUT', Apr 20 20:54:45 volumio volumio[14878]: syscall: 'connect', Apr 20 20:54:45 volumio volumio[14878]: address: '108.160.166.61', Apr 20 20:54:45 volumio volumio[14878]: port: 443 Apr 20 20:54:45 volumio volumio[14878]: } Apr 20 20:54:45 volumio volumio[14878]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 20 20:54:46 volumio sudo[15433]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-20 20:53 Apr 20 20:54:46 volumio sudo[15433]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"