-- Logs begin at Sat 2025-06-14 18:01:02 CST, end at Sat 2025-06-14 18:24:48 CST. -- Jun 14 18:23:04 volumio sudo[6542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 14 18:23:04 volumio sudo[6542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:23:04 volumio sudo[6542]: pam_unix(sudo:session): session closed for user root Jun 14 18:23:04 volumio sudo[6545]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 18:23:04 volumio sudo[6545]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:23:04 volumio sudo[6545]: pam_unix(sudo:session): session closed for user root Jun 14 18:23:04 volumio volumio[932]: verbose: New Socket.io Connection to 192.168.3.187 from 192.168.3.18 UA: Mozilla/5.0 (Linux; Android 12; HarmonyOS; TAS-AN00; HMSCore 6.15.0.312) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/114.0.5735.196 HuaweiBrowser/16.0.5.311 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jun 14 18:23:05 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 14 18:23:05 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 14 18:23:05 volumio sudo[6550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 14 18:23:05 volumio sudo[6550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:23:05 volumio sudo[6550]: pam_unix(sudo:session): session closed for user root Jun 14 18:23:05 volumio sudo[6553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 14 18:23:05 volumio sudo[6553]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 14 18:23:05 volumio sudo[6553]: pam_unix(sudo:session): session closed for user root Jun 14 18:23:05 volumio volumio[932]: verbose: New Socket.io Connection to 192.168.3.187 from 192.168.3.18 UA: Mozilla/5.0 (Linux; Android 12; HarmonyOS; TAS-AN00; HMSCore 6.15.0.312) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/114.0.5735.196 HuaweiBrowser/16.0.5.311 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 8 Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::volumioGetVisibleSources Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::volumioGetState Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 14 18:23:06 volumio volumio[932]: info: Received Get System Info Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 14 18:23:06 volumio volumio[932]: info: Discovery: Getting this device information Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::volumioGetState Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::volumioGetState Jun 14 18:23:06 volumio volumio[932]: info: Listing playlists Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Jun 14 18:23:06 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 14 18:23:06 volumio volumio[932]: An internal error occurred while serving an albumart. Details: Error: ENOENT: no such file or directory, stat '/data/albumart/web/%E7%A8%8B%E5%93%8D/%E7%AD%89%E4%BD%A0%E5%BD%92%E6%9D%A5/f2d10fde-de42-4b66-be8c-41c7adfbce8b.jpg' Jun 14 18:23:07 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 14 18:23:07 volumio volumio[932]: info: Received Get System Info Jun 14 18:23:07 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 14 18:23:07 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 14 18:23:07 volumio volumio[932]: info: Discovery: Getting this device information Jun 14 18:23:07 volumio volumio[932]: info: CoreCommandRouter::volumioGetState Jun 14 18:23:07 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 14 18:23:08 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Jun 14 18:23:15 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 14 18:23:17 volumio volumio[932]: info: Jun 14 18:23:17 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:23:17 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:23:17 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:23:17 volumio volumio[932]: info: Jun 14 18:23:17 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:23:17 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:23:17 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:23:17 volumio volumio[932]: info: Jun 14 18:23:17 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:23:17 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:23:17 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:23:17 volumio volumio[932]: info: sendMpdCommand status took 2 milliseconds Jun 14 18:23:17 volumio volumio[932]: info: sendMpdCommand status took 1 milliseconds Jun 14 18:23:17 volumio volumio[932]: verbose: ControllerMpd::parseState Jun 14 18:23:17 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: CorePlayQueue::getTrack 2 Jun 14 18:23:17 volumio volumio[932]: 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} Jun 14 18:23:17 volumio volumio[932]: verbose: CURRENT POSITION 2 Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus play Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::stPlaybackTimer Jun 14 18:23:17 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:23:17 volumio volumio[932]: 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} Jun 14 18:23:17 volumio volumio[932]: verbose: CURRENT POSITION 0 Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: No code Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:23:17 volumio volumio[932]: 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} Jun 14 18:23:17 volumio volumio[932]: verbose: CURRENT POSITION 0 Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::syncState stateService stop Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: No code Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:17 volumio volumio[932]: info: ------------------------------ 43ms Jun 14 18:23:17 volumio volumio[932]: info: ------------------------------ 43ms Jun 14 18:23:17 volumio volumio[932]: info: ------------------------------ 43ms Jun 14 18:23:17 volumio volumio[932]: info: CoreCommandRouter::volumioGetQueue Jun 14 18:23:17 volumio volumio[932]: info: CoreStateMachine::getQueue Jun 14 18:23:17 volumio volumio[932]: info: CorePlayQueue::getQueue Jun 14 18:23:21 volumio volumio[932]: info: CoreCommandRouter::volumioGetQueue Jun 14 18:23:21 volumio volumio[932]: info: CoreStateMachine::getQueue Jun 14 18:23:21 volumio volumio[932]: info: CorePlayQueue::getQueue Jun 14 18:23:23 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 14 18:23:23 volumio volumio[932]: info: CURURI: playlists Jun 14 18:23:23 volumio volumio[932]: info: Listing playlists Jun 14 18:23:23 volumio volumio[932]: info: Preload queue cleared Jun 14 18:23:25 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 14 18:23:25 volumio volumio[932]: info: CURURI: playlists/1 Jun 14 18:23:25 volumio volumio[932]: info: Preload queue cleared Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::ClearQueue Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::stop Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::clearPlayQueue Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::saveQueue Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioPushQueue Jun 14 18:23:31 volumio volumio[932]: info: Play playlist 1 Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioClearQueue Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::ClearQueue Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::stop Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::clearPlayQueue Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::saveQueue Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioPushQueue Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioAddQueueItems Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::addQueueItems Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::addQueueItems Jun 14 18:23:31 volumio volumio[932]: info: Preload queue cleared Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioPushQueue Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::saveQueue Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::updateTrackBlock Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::getTrackBlock Jun 14 18:23:31 volumio volumio[932]: info: CoreCommandRouter::volumioPlay Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::play index 0 Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::stop Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::play index undefined Jun 14 18:23:31 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:23:31 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:23:36 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 14 18:23:36 volumio volumio[932]: info: CURURI: music-library Jun 14 18:23:36 volumio volumio[932]: info: Preload queue cleared Jun 14 18:23:38 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 14 18:23:38 volumio volumio[932]: info: CURURI: music-library/INTERNAL Jun 14 18:23:38 volumio volumio[932]: info: Preload queue cleared Jun 14 18:23:46 volumio volumio[932]: info: Listing playlists Jun 14 18:24:04 volumio volumio[932]: info: CoreCommandRouter::volumioplayNextItems Jun 14 18:24:04 volumio volumio[932]: info: CoreStateMachine::playNextItems Jun 14 18:24:04 volumio volumio[932]: info: CorePlayQueue::addPlayNextItems Jun 14 18:24:04 volumio volumio[932]: info: Preload queue cleared Jun 14 18:24:04 volumio volumio[932]: info: Adding Item to play next: music-library/INTERNAL Jun 14 18:24:04 volumio volumio[932]: info: Exploding uri music-library/INTERNAL in service mpd Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Sunny%20Bay/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20A%20Woodland%20Night.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - A Woodland Night.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Wonderland/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Annie's%20Wonderland.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Annie's Wonderland.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/One%20day%20in%20Spring/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Beatrix.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Beatrix.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/MistyLand/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Beyond%20The%20Memory%20Of%20Man.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Beyond The Memory Of Man.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Moonlight%20Bay/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Caribbean%20Blue.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Caribbean Blue.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Silence%20With%20Sound%20From%20Nature/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Chariots%20Of%20Fire.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Chariots Of Fire.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Sunny%20Bay/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Childhood%20Memory.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Childhood Memory.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Relaxation%20-%20Dreams/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Dream%20Catcher.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Dream Catcher.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Breezy%20Valley/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Dreaming%20In%20The%20Moonlight.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Dreaming In The Moonlight.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/One%20day%20in%20Spring/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Earth%20melody.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Earth melody.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Silence%20With%20Sound%20From%20Nature/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20El%20C%C3%B3ndor%20Pasa.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - El Cóndor Pasa.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Heaven%20Blue/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Endless%20Horizon.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Endless Horizon.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/One%20day%20in%20Spring/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Fairyland.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Fairyland.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Breezy%20Valley/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20For%20Your%20Heart%20Only.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - For Your Heart Only.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Breezy%20Valley/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Good%20Morning%20Sunshine.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Good Morning Sunshine.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Breezy%20Valley/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Green%20Leaves%20Of%20Spring.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Green Leaves Of Spring.mp3 Jun 14 18:24:04 volumio volumio[932]: info: ALBUMART /albumart?cacheid=508&web=Bandari/Breezy%20Valley/extralarge&path=%2Fmnt%2FINTERNAL%2FBandari%20-%20Heaven%20On%20Earth.mp3&metadata=false Jun 14 18:24:04 volumio volumio[932]: info: URI /mnt/INTERNAL/Bandari - Heaven On Earth.mp3 Jun 14 18:24:04 volumio volumio[932]: info: CoreCommandRouter::volumioPushQueue Jun 14 18:24:04 volumio volumio[932]: info: CorePlayQueue::saveQueue Jun 14 18:24:04 volumio volumio[932]: info: CoreStateMachine::updateTrackBlock Jun 14 18:24:04 volumio volumio[932]: info: CorePlayQueue::getTrackBlock Jun 14 18:24:08 volumio volumio[932]: info: Listing playlists Jun 14 18:24:11 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , handleBrowseUri Jun 14 18:24:11 volumio volumio[932]: info: CURURI: music-library/INTERNAL Jun 14 18:24:11 volumio volumio[932]: info: Preload queue cleared Jun 14 18:24:23 volumio volumio[932]: info: Preload queue cleared Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioReplaceandPlayItems Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::ClearQueue Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::stop Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::clearPlayQueue Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::saveQueue Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushQueue Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::addQueueItems Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::addQueueItems Jun 14 18:24:23 volumio volumio[932]: info: Preload queue cleared Jun 14 18:24:23 volumio volumio[932]: info: Adding Item to queue: music-library/INTERNAL/Bandari - Dreaming In The Moonlight.mp3 Jun 14 18:24:23 volumio volumio[932]: info: Using cached record of: music-library/INTERNAL/Bandari - Dreaming In The Moonlight.mp3 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushQueue Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::saveQueue Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::updateTrackBlock Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrackBlock Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPlay Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::play index 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::stop Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::play index undefined Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::setConsumeUpdateService undefined Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::startPlaybackTimer Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::clearAddPlayTracks INTERNAL/Bandari - Dreaming In The Moonlight.mp3 Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand stop Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand stop took 1 milliseconds Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand clear Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand clear took 0 milliseconds Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand add "INTERNAL/Bandari - Dreaming In The Moonlight.mp3" Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces system playlist update Jun 14 18:24:23 volumio volumio[932]: info: Ignoring MPD Status Update Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces system playlist update Jun 14 18:24:23 volumio volumio[932]: info: Ignoring MPD Status Update Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand add "INTERNAL/Bandari - Dreaming In The Moonlight.mp3" took 1 milliseconds Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand play Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces system playlist update Jun 14 18:24:23 volumio volumio[932]: info: Ignoring MPD Status Update Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces system playlist update Jun 14 18:24:23 volumio volumio[932]: info: Ignoring MPD Status Update Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 6ms Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand play took 6 milliseconds Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 5ms Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 4ms Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces system playlist update Jun 14 18:24:23 volumio volumio[932]: info: Ignoring MPD Status Update Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces system playlist update Jun 14 18:24:23 volumio volumio[932]: info: Ignoring MPD Status Update Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:24:23 volumio volumio[932]: error: Upnp client error: Error: This socket has been ended by the other party Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand status took 3 milliseconds Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 3ms Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 2ms Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand status took 2 milliseconds Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:24:23 volumio volumio[932]: info: Jun 14 18:24:23 volumio volumio[932]: ---------------------------- MPD announces state update: player Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::getState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand status Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand status took 3 milliseconds Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand playlistinfo took 2 milliseconds Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand status took 1 milliseconds Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseTrackInfo Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseTrackInfo Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreaming In The Moonlight","artist":"Bandari","album":"Breezy Valley","uri":"INTERNAL/Bandari - Dreaming In The Moonlight.mp3","trackType":"mp3"} Jun 14 18:24:23 volumio volumio[932]: verbose: CURRENT POSITION 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState stateService play Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus stop Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreaming In The Moonlight","artist":"Bandari","album":"Breezy Valley","uri":"INTERNAL/Bandari - Dreaming In The Moonlight.mp3","trackType":"mp3"} Jun 14 18:24:23 volumio volumio[932]: verbose: CURRENT POSITION 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState stateService play Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus play Jun 14 18:24:23 volumio volumio[932]: info: Received an update from plugin. extracting info from payload Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 16ms Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 19ms Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand status took 17 milliseconds Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand playlistinfo took 17 milliseconds Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand playlistinfo took 18 milliseconds Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseState Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::sendMpdCommand playlistinfo Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseTrackInfo Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreaming In The Moonlight","artist":"Bandari","album":"Breezy Valley","uri":"INTERNAL/Bandari - Dreaming In The Moonlight.mp3","trackType":"mp3"} Jun 14 18:24:23 volumio volumio[932]: verbose: CURRENT POSITION 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState stateService play Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus play Jun 14 18:24:23 volumio volumio[932]: info: Received an update from plugin. extracting info from payload Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreaming In The Moonlight","artist":"Bandari","album":"Breezy Valley","uri":"INTERNAL/Bandari - Dreaming In The Moonlight.mp3","trackType":"mp3"} Jun 14 18:24:23 volumio volumio[932]: verbose: CURRENT POSITION 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState stateService play Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus play Jun 14 18:24:23 volumio volumio[932]: info: Received an update from plugin. extracting info from payload Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 51ms Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 49ms Jun 14 18:24:23 volumio volumio[932]: info: sendMpdCommand playlistinfo took 34 milliseconds Jun 14 18:24:23 volumio volumio[932]: verbose: ControllerMpd::parseTrackInfo Jun 14 18:24:23 volumio volumio[932]: info: ControllerMpd::pushState Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::servicePushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: verbose: STATE SERVICE {"status":"play","position":0,"seek":0,"duration":291,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"Dreaming In The Moonlight","artist":"Bandari","album":"Breezy Valley","uri":"INTERNAL/Bandari - Dreaming In The Moonlight.mp3","trackType":"mp3"} Jun 14 18:24:23 volumio volumio[932]: verbose: CURRENT POSITION 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState stateService play Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::syncState currentStatus play Jun 14 18:24:23 volumio volumio[932]: info: Received an update from plugin. extracting info from payload Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: CoreStateMachine::pushState Jun 14 18:24:23 volumio volumio[932]: info: CorePlayQueue::getTrack 0 Jun 14 18:24:23 volumio volumio[932]: info: CoreCommandRouter::volumioPushState Jun 14 18:24:23 volumio volumio[932]: info: ------------------------------ 71ms Jun 14 18:24:39 volumio volumio[932]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Jun 14 18:24:40 volumio volumio[932]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Jun 14 18:24:48 volumio volumio[932]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 18:24:48 volumio volumio[932]: Error: connect ETIMEDOUT 185.60.216.11:443 Jun 14 18:24:48 volumio volumio[932]: at TCPConnectWrap.afterConnect [as oncomplete] (net.js:1159:16) { Jun 14 18:24:48 volumio volumio[932]: errno: -110, Jun 14 18:24:48 volumio volumio[932]: code: 'ETIMEDOUT', Jun 14 18:24:48 volumio volumio[932]: syscall: 'connect', Jun 14 18:24:48 volumio volumio[932]: address: '185.60.216.11', Jun 14 18:24:48 volumio volumio[932]: port: 443 Jun 14 18:24:48 volumio volumio[932]: } Jun 14 18:24:48 volumio volumio[932]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 14 18:24:48 volumio sudo[6918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-14 18:23 Jun 14 18:24:48 volumio sudo[6918]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:50:12 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="39b0f8c200b2dcadf117e189b4b3632d"