Jun 05 15:46:06 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:06 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/best Jun 05 15:46:06 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:08 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:46:08 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:46:13 volumio go-librespot[6686]: time="2025-06-05T15:46:13+01:00" level=trace msg="sent dealer ping" Jun 05 15:46:13 volumio go-librespot[6686]: time="2025-06-05T15:46:13+01:00" level=trace msg="received dealer pong" Jun 05 15:46:14 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:14 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/location Jun 05 15:46:14 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:15 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:15 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101217 Jun 05 15:46:15 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101217 Jun 05 15:46:16 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:16 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:16 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101309 Jun 05 15:46:16 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101309 Jun 05 15:46:17 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:17 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:18 volumio go-librespot[6686]: time="2025-06-05T15:46:18+01:00" level=trace msg="received accesspoint ping" Jun 05 15:46:18 volumio go-librespot[6686]: time="2025-06-05T15:46:18+01:00" level=trace msg="received accesspoint pong ack" Jun 05 15:46:18 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:46:18 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:46:18 volumio volumio[6386]: info: Listing playlists Jun 05 15:46:18 volumio volumio[6386]: info: Listing playlists Jun 05 15:46:20 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:20 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101309&pivot=name&filter=country Jun 05 15:46:20 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101309&pivot=name&filter=country Jun 05 15:46:20 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:21 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:21 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101309&filter=s:~B:country Jun 05 15:46:21 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101309&filter=s:~B:country Jun 05 15:46:21 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:25 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:25 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?offset=26&id=r101309&filter=s:~B:country Jun 05 15:46:25 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?offset=26&id=r101309&filter=s:~B:country Jun 05 15:46:25 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:28 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:46:28 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:46:31 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:31 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?offset=52&id=r101309&filter=s:~B:country Jun 05 15:46:31 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?offset=52&id=r101309&filter=s:~B:country Jun 05 15:46:31 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:39 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:46:39 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:46:39 volumio volumio[6386]: info: Listing playlists Jun 05 15:46:39 volumio volumio[6386]: info: Listing playlists Jun 05 15:46:41 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:41 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?offset=26&id=r101309&filter=s:~B:country Jun 05 15:46:41 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?offset=26&id=r101309&filter=s:~B:country Jun 05 15:46:41 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:43 volumio go-librespot[6686]: time="2025-06-05T15:46:43+01:00" level=trace msg="sent dealer ping" Jun 05 15:46:43 volumio go-librespot[6686]: time="2025-06-05T15:46:43+01:00" level=trace msg="received dealer pong" Jun 05 15:46:49 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:46:49 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:46:50 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:50 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101309&pivot=name&filter=country Jun 05 15:46:50 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101309&pivot=name&filter=country Jun 05 15:46:50 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:53 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:53 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?id=r101309&filter=s:~B:country Jun 05 15:46:53 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?id=r101309&filter=s:~B:country Jun 05 15:46:53 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:56 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:46:56 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?offset=26&id=r101309&filter=s:~B:country Jun 05 15:46:56 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?offset=26&id=r101309&filter=s:~B:country Jun 05 15:46:56 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:46:59 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:46:59 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:46:59 volumio volumio[6386]: info: Listing playlists Jun 05 15:46:59 volumio volumio[6386]: info: Listing playlists Jun 05 15:47:00 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:47:00 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/browse/?offset=52&id=r101309&filter=s:~B:country Jun 05 15:47:00 volumio volumio[6386]: info: [TuneIn] Fetching (browse) results For tunein/browse/?offset=52&id=r101309&filter=s:~B:country Jun 05 15:47:00 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:47:09 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:47:09 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:47:12 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:47:12 volumio volumio[6386]: info: Getting webradio selection Jun 05 15:47:12 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:47:13 volumio go-librespot[6686]: time="2025-06-05T15:47:13+01:00" level=trace msg="sent dealer ping" Jun 05 15:47:13 volumio go-librespot[6686]: time="2025-06-05T15:47:13+01:00" level=trace msg="received dealer pong" Jun 05 15:47:17 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:47:18 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:47:19 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:47:19 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:47:19 volumio volumio[6386]: info: Listing playlists Jun 05 15:47:19 volumio volumio[6386]: info: Listing playlists Jun 05 15:47:20 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:47:20 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:47:23 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service... Jun 05 15:47:23 volumio dbus-daemon[598]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.108' (uid=0 pid=8544 comm="timedatectl show --property=NTPSynchronized --valu") Jun 05 15:47:23 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service... Jun 05 15:47:23 volumio dbus-daemon[598]: [system] Successfully activated service 'org.freedesktop.timedate1' Jun 05 15:47:23 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service. Jun 05 15:47:23 volumio setdatetime-helper.sh[8543]: Time is not synchronized. Attempting to sync... Jun 05 15:47:26 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , handleBrowseUri Jun 05 15:47:26 volumio volumio[6386]: info: TuneIn handleBrowseUri: tunein/popular Jun 05 15:47:26 volumio volumio[6386]: info: Preload queue cleared Jun 05 15:47:28 volumio sudo[8567]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Thu, 05 Jun 2025 14:47:28 GMT#015' Jun 05 15:47:28 volumio sudo[8567]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Jun 05 15:47:28 volumio setdatetime-helper.sh[8568]: Thu Jun 5 15:47:28 BST 2025 Jun 05 15:47:28 volumio setdatetime-helper.sh[8543]: Time synchronized successfully. Jun 05 15:47:28 volumio sudo[8567]: pam_unix(sudo:session): session closed for user root Jun 05 15:47:28 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully. Jun 05 15:47:28 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service. Jun 05 15:47:28 volumio systemd-journald[349]: Time jumped backwards, rotating. Jun 05 15:47:28 volumio volumio[6386]: info: CoreCommandRouter::volumioGetState Jun 05 15:47:28 volumio volumio[6386]: info: CorePlayQueue::getTrack 0 Jun 05 15:47:30 volumio volumio[6386]: Searching plugin music_service/webradio Jun 05 15:47:30 volumio volumio[6386]: info: CoreCommandRouter::executeOnPlugin: webradio , search Jun 05 15:47:31 volumio volumio[6386]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 15:47:31 volumio volumio[6386]: TypeError: Cannot read properties of undefined (reading 'length') Jun 05 15:47:31 volumio volumio[6386]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:186:126 Jun 05 15:47:31 volumio volumio[6386]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49) Jun 05 15:47:31 volumio volumio[6386]: at /volumio/app/plugins/music_service/webradio/index.js:949:31 Jun 05 15:47:31 volumio volumio[6386]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5) Jun 05 15:47:31 volumio volumio[6386]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 05 15:47:31 volumio sudo[8584]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-05 15:46' Jun 05 15:47:31 volumio sudo[8584]: 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"