Jun 02 21:17:00 rpi4-argon volumio[1462]: info: Executing endpoint metavolumio Jun 02 21:17:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 21:17:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 02 21:17:00 rpi4-argon volumio[1462]: info: Received Get System Info Jun 02 21:17:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:17:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:17:00 rpi4-argon volumio[1462]: info: Discovery: Getting this device information Jun 02 21:17:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::volumioGetState Jun 02 21:17:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:17:00 rpi4-argon volumio[1462]: info: Executing endpoint metavolumio Jun 02 21:17:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 21:17:00 rpi4-argon volumio[1462]: error: Failed request for metavolumio API Jun 02 21:17:00 rpi4-argon volumio[1462]: info: TidalConnect service started! Jun 02 21:17:01 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:01 rpi4-argon CRON[2681]: pam_unix(cron:session): session opened for user root(uid=0) by (uid=0) Jun 02 21:17:01 rpi4-argon CRON[2683]: (root) CMD (cd / && run-parts --report /etc/cron.hourly) Jun 02 21:17:01 rpi4-argon CRON[2682]: pam_unix(cron:session): session opened for user volumio(uid=1000) by (uid=0) Jun 02 21:17:01 rpi4-argon CRON[2684]: (volumio) CMD (sudo /bin/bash /home/volumio/scripts/date_time.sh) Jun 02 21:17:01 rpi4-argon sudo[2686]: pam_unix(sudo:auth): conversation failed Jun 02 21:17:01 rpi4-argon sudo[2686]: pam_unix(sudo:auth): auth could not identify password for [volumio] Jun 02 21:17:01 rpi4-argon CRON[2681]: pam_unix(cron:session): session closed for user root Jun 02 21:17:01 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Jun 02 21:17:01 rpi4-argon exim[2694]: 2025-06-02 21:17:01 1uMAeb-0000hS-2g <= volumio@localhost U=volumio P=local S=539 Jun 02 21:17:01 rpi4-argon exim[2694]: 2025-06-02 21:17:01 1uMAeb-0000hS-2g Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=112 egid=117 Jun 02 21:17:01 rpi4-argon exim[2694]: exim: could not open panic log - aborting: see message(s) above Jun 02 21:17:01 rpi4-argon cron[2695]: 2025-06-02 21:17:01 1uMAeb-0000hT-2i Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=112 egid=117 Jun 02 21:17:01 rpi4-argon cron[2695]: 2025-06-02 21:17:01 1uMAeb-0000hT-2i <= volumio@localhost U=volumio P=local S=775 Jun 02 21:17:01 rpi4-argon cron[2695]: 2025-06-02 21:17:01 1uMAeb-0000hT-2i Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=112 egid=117 Jun 02 21:17:01 rpi4-argon cron[2695]: exim: could not open panic log - aborting: see message(s) above Jun 02 21:17:01 rpi4-argon exim[2695]: 2025-06-02 21:17:01 1uMAeb-0000hT-2i <= volumio@localhost U=volumio P=local S=775 Jun 02 21:17:01 rpi4-argon exim[2695]: 2025-06-02 21:17:01 1uMAeb-0000hT-2i Cannot open main log file "/var/log/exim4/mainlog": Permission denied: euid=112 egid=117 Jun 02 21:17:01 rpi4-argon exim[2695]: exim: could not open panic log - aborting: see message(s) above Jun 02 21:17:01 rpi4-argon CRON[2682]: (volumio) MAIL (mailed 164 bytes of output but got status 0x0001 from MTA ) Jun 02 21:17:01 rpi4-argon CRON[2682]: pam_unix(cron:session): session closed for user volumio Jun 02 21:17:02 rpi4-argon systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 02 21:17:02 rpi4-argon dbus-daemon[672]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.42' (uid=0 pid=2697 comm="timedatectl show --property=NTPSynchronized --valu") Jun 02 21:17:02 rpi4-argon systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 02 21:17:02 rpi4-argon dbus-daemon[672]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 02 21:17:02 rpi4-argon systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 02 21:17:02 rpi4-argon setdatetime-helper.sh[2696]: Time is not synchronized. Attempting to sync... Jun 02 21:17:02 rpi4-argon sudo[2705]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 02 Jun 2025 19:17:02 GMT#015' Jun 02 21:17:02 rpi4-argon sudo[2705]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 02 21:17:02 rpi4-argon setdatetime-helper.sh[2706]: Mon Jun 2 21:17:02 CEST 2025 Jun 02 21:17:02 rpi4-argon setdatetime-helper.sh[2696]: Time synchronized successfully. Jun 02 21:17:02 rpi4-argon sudo[2705]: pam_unix(sudo:session): session closed for user root Jun 02 21:17:02 rpi4-argon systemd-journald[351]: Time jumped backwards, rotating. Jun 02 21:17:02 rpi4-argon systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 02 21:17:02 rpi4-argon systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 02 21:17:05 rpi4-argon volumio[1462]: info: CoreCommandRouter::volumioGetState Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Jun 02 21:17:06 rpi4-argon volumio[1462]: info: Received Get System Version Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:17:06 rpi4-argon volumio[1462]: info: Received Get System Info Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 02 21:17:06 rpi4-argon volumio[1462]: info: Discovery: Getting this device information Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CoreCommandRouter::volumioGetState Jun 02 21:17:06 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 02 21:17:07 rpi4-argon volumio[1462]: info: Executing endpoint metavolumio Jun 02 21:17:07 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 21:17:07 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:09 rpi4-argon volumio[1462]: error: Failed request for metavolumio API Jun 02 21:17:13 rpi4-argon go-librespot[1804]: time="2025-06-02T21:17:13+02:00" level=trace msg="sent dealer ping" Jun 02 21:17:13 rpi4-argon go-librespot[1804]: time="2025-06-02T21:17:13+02:00" level=trace msg="received dealer pong" Jun 02 21:17:13 rpi4-argon volumio[1462]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 02 21:17:13 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 02 21:17:14 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 02 21:17:14 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 02 21:17:14 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Jun 02 21:17:14 rpi4-argon volumio[1462]: info: Received Get System Version Jun 02 21:17:14 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 02 21:17:14 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:20 rpi4-argon volumio[1462]: info: CoreCommandRouter::volumioGetState Jun 02 21:17:20 rpi4-argon kernel: rc rc0: two consecutive events of type space Jun 02 21:17:21 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:22 rpi4-argon volumio[1462]: info: Executing endpoint metavolumio Jun 02 21:17:22 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Jun 02 21:17:28 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:31 rpi4-argon systemd[1]: systemd-timedated.service: Deactivated successfully. Jun 02 21:17:35 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:40 rpi4-argon volumio[1462]: info: CoreCommandRouter::volumioGetQueue Jun 02 21:17:40 rpi4-argon volumio[1462]: info: CoreStateMachine::getQueue Jun 02 21:17:40 rpi4-argon volumio[1462]: info: CorePlayQueue::getQueue Jun 02 21:17:42 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:43 rpi4-argon go-librespot[1804]: time="2025-06-02T21:17:43+02:00" level=trace msg="received accesspoint ping" Jun 02 21:17:43 rpi4-argon go-librespot[1804]: time="2025-06-02T21:17:43+02:00" level=trace msg="received accesspoint pong ack" Jun 02 21:17:43 rpi4-argon go-librespot[1804]: time="2025-06-02T21:17:43+02:00" level=trace msg="sent dealer ping" Jun 02 21:17:43 rpi4-argon go-librespot[1804]: time="2025-06-02T21:17:43+02:00" level=trace msg="received dealer pong" Jun 02 21:17:45 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jun 02 21:17:45 rpi4-argon volumio[1462]: info: handleBrowseUri took 106 milliseconds Jun 02 21:17:46 rpi4-argon volumio[1462]: info: Preload queue cleared Jun 02 21:17:46 rpi4-argon volumio[1462]: info: Preload queue cleared Jun 02 21:17:49 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:17:51 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: qobuz , handleBrowseUri Jun 02 21:17:54 rpi4-argon volumio[1462]: info: handleBrowseUri took 2238 milliseconds Jun 02 21:17:54 rpi4-argon volumio[1462]: info: Preload queue cleared Jun 02 21:17:56 rpi4-argon wpa_supplicant[1343]: RRM: Ignoring radio measurement request: Not RRM network Jun 02 21:18:00 rpi4-argon volumio[1462]: Searching all installed plugins Jun 02 21:18:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 02 21:18:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: mpd , search Jun 02 21:18:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 02 21:18:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: randomizer , search Jun 02 21:18:00 rpi4-argon volumio[1462]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin randomizer Jun 02 21:18:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: spop , search Jun 02 21:18:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: qobuz , search Jun 02 21:18:00 rpi4-argon volumio[1462]: info: CoreCommandRouter::executeOnPlugin: tidal , search Jun 02 21:18:00 rpi4-argon volumio[1462]: Use XMLElement.setAttribute instead Jun 02 21:18:00 rpi4-argon volumio[1462]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:18:00 rpi4-argon volumio[1462]: TypeError: children[i].attr(...).value is not a function Jun 02 21:18:00 rpi4-argon volumio[1462]: at /volumio/app/plugins/music_service/webradio/index.js:956:46 Jun 02 21:18:00 rpi4-argon volumio[1462]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 02 21:18:00 rpi4-argon volumio[1462]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 02 21:18:01 rpi4-argon sudo[2907]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-02 21:17' Jun 02 21:18:01 rpi4-argon sudo[2907]: 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="a42e8353c03f8616e137cf760ea618e88c395461" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon Jun 2 16:20:51 UTC 2025" VOLUMIO_VERSION="4.010" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="f51ec0ad91e50bdfdb863e902a9e8fa2"