Jun 23 10:21:01 volumio volumio[1210]: verbose: New Socket.io Connection to 192.168.1.229:3000 from 192.168.1.228 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9
Jun 23 10:21:28 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Jun 23 10:21:28 volumio dbus-daemon[596]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.45' (uid=0 pid=4375 comm="timedatectl show --property=NTPSynchronized --valu")
Jun 23 10:21:28 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Jun 23 10:21:28 volumio dbus-daemon[596]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jun 23 10:21:28 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Jun 23 10:21:28 volumio setdatetime-helper.sh[4374]: Time is not synchronized. Attempting to sync...
Jun 23 10:21:28 volumio sudo[4383]: root : PWD=/ ; USER=root ; COMMAND=/usr/bin/date -s 'Mon, 23 Jun 2025 03:21:28 GMT#015'
Jun 23 10:21:28 volumio sudo[4383]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0)
Jun 23 10:21:28 volumio setdatetime-helper.sh[4384]: Mon Jun 23 10:21:28 +07 2025
Jun 23 10:21:28 volumio setdatetime-helper.sh[4374]: Time synchronized successfully.
Jun 23 10:21:28 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Jun 23 10:21:28 volumio sudo[4383]: pam_unix(sudo:session): session closed for user root
Jun 23 10:21:28 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Jun 23 10:21:28 volumio systemd-journald[324]: Time jumped backwards, rotating.
Jun 23 10:21:29 volumio go-librespot[1505]: time="2025-06-23T10:21:29+07:00" level=trace msg="sent dealer ping"
Jun 23 10:21:29 volumio go-librespot[1505]: time="2025-06-23T10:21:29+07:00" level=trace msg="received dealer pong"
Jun 23 10:21:49 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 10:21:49 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 10:21:49 volumio volumio[1210]: info: Discovery: Getting this device information
Jun 23 10:21:49 volumio volumio[1210]: info: CoreCommandRouter::volumioGetState
Jun 23 10:21:49 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 10:21:55 volumio wpa_supplicant[1089]: wlan0: WPA: Group rekeying completed with f8:2e:3f:14:80:c8 [GTK=TKIP]
Jun 23 10:21:57 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
Jun 23 10:21:58 volumio volumio[1210]: verbose: New Socket.io Connection to 192.168.1.229:3000 from 192.168.1.228 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 8
Jun 23 10:21:59 volumio go-librespot[1505]: time="2025-06-23T10:21:59+07:00" level=trace msg="sent dealer ping"
Jun 23 10:21:59 volumio go-librespot[1505]: time="2025-06-23T10:21:59+07:00" level=trace msg="received dealer pong"
Jun 23 10:22:00 volumio volumio[1210]: verbose: New Socket.io Connection to 192.168.1.229 from 192.168.1.228 UA: Mozilla/5.0 (Linux; Android 15; A059 Build/AQ3A.241015.001; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.115 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::volumioGetState
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 23 10:22:00 volumio volumio[1210]: info: Received Get System Info
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 10:22:00 volumio volumio[1210]: info: Discovery: Getting this device information
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::volumioGetState
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::volumioGetState
Jun 23 10:22:00 volumio volumio[1210]: info: Listing playlists
Jun 23 10:22:00 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache
Jun 23 10:22:27 volumio volumio[1210]: verbose: New Socket.io Connection to 192.168.1.229:3000 from 192.168.1.228 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 9
Jun 23 10:22:27 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 23 10:22:27 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 23 10:22:27 volumio volumio[1210]: info: Discovery: Getting this device information
Jun 23 10:22:27 volumio volumio[1210]: info: CoreCommandRouter::volumioGetState
Jun 23 10:22:27 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 23 10:22:28 volumio go-librespot[1505]: time="2025-06-23T10:22:28+07:00" level=trace msg="received accesspoint ping"
Jun 23 10:22:28 volumio go-librespot[1505]: time="2025-06-23T10:22:28+07:00" level=trace msg="received accesspoint pong ack"
Jun 23 10:22:29 volumio go-librespot[1505]: time="2025-06-23T10:22:29+07:00" level=trace msg="sent dealer ping"
Jun 23 10:22:29 volumio go-librespot[1505]: time="2025-06-23T10:22:29+07:00" level=trace msg="received dealer pong"
Jun 23 10:22:36 volumio volumio[1210]: info: CoreCommandRouter::volumioGetQueue
Jun 23 10:22:36 volumio volumio[1210]: info: CoreStateMachine::getQueue
Jun 23 10:22:36 volumio volumio[1210]: info: CorePlayQueue::getQueue
Jun 23 10:22:42 volumio volumio[1210]: Searching plugin music_service/webradio
Jun 23 10:22:42 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Jun 23 10:22:43 volumio volumio[1210]: Searching plugin music_service/webradio
Jun 23 10:22:43 volumio volumio[1210]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Jun 23 10:22:43 volumio volumio[1210]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 23 10:22:43 volumio volumio[1210]: TypeError: Cannot read properties of undefined (reading 'length')
Jun 23 10:22:43 volumio volumio[1210]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:186:126
Jun 23 10:22:43 volumio volumio[1210]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49)
Jun 23 10:22:43 volumio volumio[1210]: at /volumio/app/plugins/music_service/webradio/index.js:949:31
Jun 23 10:22:43 volumio volumio[1210]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Jun 23 10:22:43 volumio volumio[1210]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 23 10:22:44 volumio sudo[4670]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-06-23 10:21'
Jun 23 10:22:44 volumio sudo[4670]: 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="cee9bb5b0ee50e4898478097a64b5c6c77d5a212"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="b0310d60a07948a2a8a2e8db322034758c86aad6"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat Jun 21 15:01:23 UTC 2025"
VOLUMIO_VERSION="4.013"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="6df2d5f0b86e6f2c0cd4dc68c66de48c"