Nov 01 10:54:00 volumio volumio[1067]: info: CoreCommandRouter::volumioGetQueue Nov 01 10:54:00 volumio volumio[1067]: info: CoreStateMachine::getQueue Nov 01 10:54:00 volumio volumio[1067]: info: CorePlayQueue::getQueue Nov 01 10:54:01 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Nov 01 10:54:02 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Nov 01 10:54:02 volumio volumio[1067]: info: Received Get System Info Nov 01 10:54:02 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Nov 01 10:54:02 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Nov 01 10:54:02 volumio volumio[1067]: info: Discovery: Getting this device information Nov 01 10:54:02 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Nov 01 10:54:02 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:02 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Nov 01 10:54:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Nov 01 10:54:03 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:09 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Nov 01 10:54:09 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Nov 01 10:54:09 volumio dbus-daemon[525]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.24' (uid=0 pid=1781 comm="timedatectl show --property=NTPSynchronized --valu") Nov 01 10:54:09 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Nov 01 10:54:09 volumio dbus-daemon[525]: [system] Successfully activated service 'org.freedesktop.timedate1' Nov 01 10:54:09 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Nov 01 10:54:09 volumio setdatetime-helper.sh[1780]: Time is not synchronized. Attempting to sync... Nov 01 10:54:10 volumio sudo[1789]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Sat, 01 Nov 2025 07:54:10 GMT#015' Nov 01 10:54:10 volumio sudo[1789]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Nov 01 10:54:10 volumio setdatetime-helper.sh[1790]: Sat Nov 1 10:54:10 +03 2025 Nov 01 10:54:10 volumio systemd-journald[336]: Time jumped backwards, rotating. Nov 01 10:54:10 volumio sudo[1789]: pam_unix(sudo:session): session closed for user root Nov 01 10:54:10 volumio setdatetime-helper.sh[1780]: Time synchronized successfully. Nov 01 10:54:10 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Nov 01 10:54:10 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Nov 01 10:54:17 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 01 10:54:17 volumio volumio[1067]: info: TuneIn handleBrowseUri: tunein/best Nov 01 10:54:17 volumio volumio[1067]: info: Preload queue cleared Nov 01 10:54:21 volumio volumio[1067]: info: Preload queue cleared Nov 01 10:54:21 volumio volumio[1067]: info: CoreCommandRouter::volumioReplaceandPlayItems Nov 01 10:54:21 volumio volumio[1067]: info: CoreStateMachine::ClearQueue Nov 01 10:54:21 volumio volumio[1067]: info: CoreStateMachine::stop Nov 01 10:54:21 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:54:21 volumio volumio[1067]: info: CorePlayQueue::clearPlayQueue Nov 01 10:54:21 volumio volumio[1067]: info: CorePlayQueue::saveQueue Nov 01 10:54:21 volumio volumio[1067]: info: CoreCommandRouter::volumioPushQueue Nov 01 10:54:21 volumio volumio[1067]: info: CoreStateMachine::addQueueItems Nov 01 10:54:21 volumio volumio[1067]: info: CorePlayQueue::addQueueItems Nov 01 10:54:21 volumio volumio[1067]: info: Preload queue cleared Nov 01 10:54:21 volumio volumio[1067]: info: Adding Item to queue: http://opml.radiotime.com/Tune.ashx?id=s10161 Nov 01 10:54:21 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: webradio , explodeUri Nov 01 10:54:22 volumio volumio[1067]: info: CoreCommandRouter::volumioPushQueue Nov 01 10:54:22 volumio volumio[1067]: info: CorePlayQueue::saveQueue Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::updateTrackBlock Nov 01 10:54:22 volumio volumio[1067]: info: CorePlayQueue::getTrackBlock Nov 01 10:54:22 volumio volumio[1067]: info: CoreCommandRouter::volumioPlay Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::play index 0 Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::stop Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::play index undefined Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService undefined Nov 01 10:54:22 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:22 volumio volumio[1067]: info: CoreStateMachine::startPlaybackTimer Nov 01 10:54:22 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:22 volumio volumio[1067]: info: [1761983662520] ControllerWebradio::clearAddPlayTrack Nov 01 10:54:22 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand stop Nov 01 10:54:22 volumio volumio[1067]: info: sendMpdCommand stop took 29 milliseconds Nov 01 10:54:22 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand clear Nov 01 10:54:22 volumio volumio[1067]: info: Nov 01 10:54:22 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Nov 01 10:54:22 volumio volumio[1067]: info: Ignoring MPD Status Update Nov 01 10:54:22 volumio volumio[1067]: info: sendMpdCommand clear took 20 milliseconds Nov 01 10:54:22 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand load "http://kralwmp.radyotvonline.com/" Nov 01 10:54:22 volumio volumio[1067]: info: Nov 01 10:54:22 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Nov 01 10:54:22 volumio volumio[1067]: info: Ignoring MPD Status Update Nov 01 10:54:22 volumio volumio[1067]: info: Nov 01 10:54:22 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Nov 01 10:54:22 volumio volumio[1067]: info: Ignoring MPD Status Update Nov 01 10:54:22 volumio volumio[1067]: error: updateQueue error: null Nov 01 10:54:22 volumio volumio[1067]: info: ------------------------------ 64ms Nov 01 10:54:24 volumio mpd[1312]: exception: No such playlist Nov 01 10:54:24 volumio volumio[1067]: error: updateQueue error: null Nov 01 10:54:24 volumio volumio[1067]: error: updateQueue error: null Nov 01 10:54:24 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand add "http://kralwmp.radyotvonline.com/" Nov 01 10:54:24 volumio volumio[1067]: info: ------------------------------ 1505ms Nov 01 10:54:24 volumio volumio[1067]: info: ------------------------------ 1503ms Nov 01 10:54:24 volumio volumio[1067]: info: Nov 01 10:54:24 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Nov 01 10:54:24 volumio volumio[1067]: info: Ignoring MPD Status Update Nov 01 10:54:24 volumio volumio[1067]: info: sendMpdCommand add "http://kralwmp.radyotvonline.com/" took 15 milliseconds Nov 01 10:54:24 volumio volumio[1067]: info: CoreStateMachine::setConsumeUpdateService mpd Nov 01 10:54:24 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand play Nov 01 10:54:24 volumio volumio[1067]: info: Nov 01 10:54:24 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Nov 01 10:54:24 volumio volumio[1067]: info: Ignoring MPD Status Update Nov 01 10:54:24 volumio volumio[1067]: info: Nov 01 10:54:24 volumio volumio[1067]: ---------------------------- MPD announces system playlist update Nov 01 10:54:24 volumio volumio[1067]: info: Ignoring MPD Status Update Nov 01 10:54:24 volumio volumio[1067]: info: ------------------------------ 81ms Nov 01 10:54:24 volumio volumio[1067]: info: sendMpdCommand play took 68 milliseconds Nov 01 10:54:24 volumio volumio[1067]: info: ------------------------------ 63ms Nov 01 10:54:24 volumio volumio[1067]: info: ------------------------------ 59ms Nov 01 10:54:25 volumio mpd[1312]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied Nov 01 10:54:25 volumio mpd[1312]: exception: Failed to open "default detected output" (sndio); Requested audio params cannot be satisfied Nov 01 10:54:25 volumio mpd[1312]: player: problems opening audio device while playing "http://kralwmp.radyotvonline.com/" Nov 01 10:54:25 volumio volumio[1067]: info: Nov 01 10:54:25 volumio volumio[1067]: ---------------------------- MPD announces state update: player Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::getState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:54:25 volumio volumio[1067]: info: Nov 01 10:54:25 volumio volumio[1067]: ---------------------------- MPD announces state update: player Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::getState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:54:25 volumio volumio[1067]: info: Nov 01 10:54:25 volumio volumio[1067]: ---------------------------- MPD announces state update: player Nov 01 10:54:25 volumio volumio[1067]: info: Nov 01 10:54:25 volumio volumio[1067]: ---------------------------- MPD announces state update: player Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::getState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand clearerror Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand status took 99 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::getState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand clearerror Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand status took 82 milliseconds Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:54:25 volumio volumio[1067]: info: Nov 01 10:54:25 volumio volumio[1067]: ---------------------------- MPD announces state update: player Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::getState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:54:25 volumio volumio[1067]: info: Nov 01 10:54:25 volumio volumio[1067]: ---------------------------- MPD announces state update: player Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::getState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand status Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand clearerror Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand status took 158 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand clearerror took 115 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand status took 116 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand clearerror took 117 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 71 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 66 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand status took 58 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand status took 52 milliseconds Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseState Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::sendMpdCommand playlistinfo Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::pushState Nov 01 10:54:25 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Nov 01 10:54:25 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:25 volumio volumio[1067]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://kralwmp.radyotvonline.com/","trackType":"com/"} Nov 01 10:54:25 volumio volumio[1067]: verbose: CURRENT POSITION 0 Nov 01 10:54:25 volumio volumio[1067]: info: CoreStateMachine::syncState stateService pause Nov 01 10:54:25 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop Nov 01 10:54:25 volumio volumio[1067]: info: CoreStateMachine::pushState Nov 01 10:54:25 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:54:25 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Nov 01 10:54:25 volumio volumio[1067]: info: ControllerMpd::pushState Nov 01 10:54:25 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Nov 01 10:54:25 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:25 volumio volumio[1067]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://kralwmp.radyotvonline.com/","trackType":"com/"} Nov 01 10:54:25 volumio volumio[1067]: verbose: CURRENT POSITION 0 Nov 01 10:54:25 volumio volumio[1067]: info: CoreStateMachine::syncState stateService pause Nov 01 10:54:25 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop Nov 01 10:54:25 volumio volumio[1067]: info: CoreStateMachine::pushState Nov 01 10:54:25 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Nov 01 10:54:25 volumio volumio[1067]: info: ------------------------------ 434ms Nov 01 10:54:25 volumio volumio[1067]: info: ------------------------------ 420ms Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand clearerror took 280 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 256 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 252 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 233 milliseconds Nov 01 10:54:25 volumio volumio[1067]: info: sendMpdCommand playlistinfo took 232 milliseconds Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:54:25 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:54:26 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:54:26 volumio volumio[1067]: verbose: ControllerMpd::parseTrackInfo Nov 01 10:54:26 volumio volumio[1067]: info: ControllerMpd::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Nov 01 10:54:26 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:26 volumio volumio[1067]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://kralwmp.radyotvonline.com/","trackType":"com/"} Nov 01 10:54:26 volumio volumio[1067]: verbose: CURRENT POSITION 0 Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState stateService pause Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Nov 01 10:54:26 volumio volumio[1067]: info: ControllerMpd::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Nov 01 10:54:26 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:26 volumio volumio[1067]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://kralwmp.radyotvonline.com/","trackType":"com/"} Nov 01 10:54:26 volumio volumio[1067]: verbose: CURRENT POSITION 0 Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState stateService pause Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Nov 01 10:54:26 volumio volumio[1067]: info: ControllerMpd::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Nov 01 10:54:26 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:26 volumio volumio[1067]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://kralwmp.radyotvonline.com/","trackType":"com/"} Nov 01 10:54:26 volumio volumio[1067]: verbose: CURRENT POSITION 0 Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState stateService pause Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Nov 01 10:54:26 volumio volumio[1067]: info: ControllerMpd::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::servicePushState Nov 01 10:54:26 volumio volumio[1067]: info: CorePlayQueue::getTrack 0 Nov 01 10:54:26 volumio volumio[1067]: verbose: STATE SERVICE {"status":"pause","position":0,"seek":0,"duration":0,"samplerate":"44.1 kHz","bitdepth":"24 bit","channels":2,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":"","artist":null,"album":null,"uri":"http://kralwmp.radyotvonline.com/","trackType":"com/"} Nov 01 10:54:26 volumio volumio[1067]: verbose: CURRENT POSITION 0 Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState stateService pause Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::syncState currentStatus stop Nov 01 10:54:26 volumio volumio[1067]: info: CoreStateMachine::pushState Nov 01 10:54:26 volumio volumio[1067]: info: CoreCommandRouter::volumioPushState Nov 01 10:54:26 volumio volumio[1067]: info: ------------------------------ 729ms Nov 01 10:54:26 volumio volumio[1067]: info: ------------------------------ 734ms Nov 01 10:54:26 volumio volumio[1067]: info: ------------------------------ 608ms Nov 01 10:54:26 volumio volumio[1067]: info: ------------------------------ 602ms Nov 01 10:54:36 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Nov 01 10:54:38 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:54:38 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 01 10:54:38 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 01 10:54:38 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Nov 01 10:54:38 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Nov 01 10:54:38 volumio volumio[1067]: info: Received Get System Version Nov 01 10:54:38 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Nov 01 10:54:39 volumio systemd[1]: systemd-timedated.service: Deactivated successfully. Nov 01 10:54:55 volumio volumio-remote-updater[536]: Test mode disabled Nov 01 10:54:55 volumio volumio-remote-updater[536]: Alpha mode disabled Nov 01 10:54:55 volumio volumio-remote-updater[536]: Alpha legacy test mode disabled Nov 01 10:54:55 volumio volumio[1067]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Nov 01 10:54:55 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Nov 01 10:54:57 volumio volumio[1067]: info: CoreCommandRouter::Close All Modals sent Nov 01 10:55:03 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:55:10 volumio volumio[1067]: info: Retrieving Cloud Streaming UI Nov 01 10:55:10 volumio volumio[1067]: info: Getting Tidal Cloud Configuration Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:55:10 volumio volumio[1067]: info: Getting Qobuz Cloud Configuration Nov 01 10:55:10 volumio volumio[1067]: info: Asking plugin for UI Config Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:55:10 volumio volumio[1067]: info: Getting Spotify Cloud Configuration Nov 01 10:55:10 volumio volumio[1067]: info: Asking plugin for UI Config Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:55:10 volumio volumio[1067]: info: Saving Spotify Acccount Nov 01 10:55:10 volumio volumio[1067]: info: Got Tidal Cloud Configuration Nov 01 10:55:10 volumio volumio[1067]: info: Got it Nov 01 10:55:10 volumio volumio[1067]: info: Got it Nov 01 10:55:10 volumio volumio[1067]: error: Could not retrieve Spotify Config from plugin Spotify: no section found Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:55:10 volumio volumio[1067]: error: Error retrieving Highresaudio conf: TypeError: Cannot read properties of undefined (reading 'onSave') Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: albumart , getConfigParam Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::volumioGetBrowseSources Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 10:55:10 volumio mpd[1312]: exception: No database Nov 01 10:55:10 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: networkfs , listShares Nov 01 10:55:14 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStats Nov 01 10:55:14 volumio mpd[1312]: exception: No database Nov 01 10:55:17 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::getUIConfigOnPlugin Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sOptions Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Nov 01 10:55:19 volumio volumio[1067]: info: Getting Alsa Cards List without I2S DAC Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2SNumber Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: mpd , getPlaybackMode Nov 01 10:55:19 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: system , getAdvancedSettingsStatus Nov 01 10:55:37 volumio volumio[1067]: info: CoreCommandRouter::volumioGetState Nov 01 10:55:43 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 01 10:55:43 volumio volumio[1067]: info: Preload queue cleared Nov 01 10:55:45 volumio volumio[1067]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Nov 01 10:55:45 volumio volumio[1067]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 10:55:45 volumio volumio[1067]: Error Nov 01 10:55:45 volumio volumio[1067]: at /volumio/app/plugins/music_service/webradio/index.js:414:31 Nov 01 10:55:45 volumio volumio[1067]: at Request.handleRequestResponse [as _callback] (/volumio/node_modules/unirest/index.js:444:15) Nov 01 10:55:45 volumio volumio[1067]: at self.callback (/volumio/node_modules/request/request.js:185:22) Nov 01 10:55:45 volumio volumio[1067]: at Request.emit (node:events:514:28) Nov 01 10:55:45 volumio volumio[1067]: at Request.onRequestError (/volumio/node_modules/request/request.js:877:8) Nov 01 10:55:45 volumio volumio[1067]: at ClientRequest.emit (node:events:514:28) Nov 01 10:55:45 volumio volumio[1067]: at Socket.socketErrorListener (node:_http_client:495:9) Nov 01 10:55:45 volumio volumio[1067]: at Socket.emit (node:events:514:28) Nov 01 10:55:45 volumio volumio[1067]: at emitErrorNT (node:internal/streams/destroy:151:8) Nov 01 10:55:45 volumio volumio[1067]: at emitErrorCloseNT (node:internal/streams/destroy:116:3) Nov 01 10:55:45 volumio volumio[1067]: at process.processTicksAndRejections (node:internal/process/task_queues:82:21) Nov 01 10:55:45 volumio volumio[1067]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Nov 01 10:55:46 volumio sudo[1991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-11-01 10:54' Nov 01 10:55:46 volumio sudo[1991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm 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="4a70cb031e64a8e498efc3e29470650871ff7d54" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat May 31 04:09:10 UTC 2025" VOLUMIO_VERSION="4.005" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f9bd4447a30d4b2c74b3880e7a50e48b"