Dec 19 13:04:00 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
Dec 19 13:04:05 volumio volumio[27700]: info: VolumeController::SetAlsaVolume49
Dec 19 13:04:05 volumio volumio[27700]: info: CoreStateMachine::pushState
Dec 19 13:04:05 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Dec 19 13:04:05 volumio volumio[27700]: info: CoreCommandRouter::volumioPushState
Dec 19 13:05:30 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Dec 19 13:05:30 volumio dbus-daemon[541]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.1693' (uid=0 pid=30069 comm="timedatectl show --property=NTPSynchronized --valu")
Dec 19 13:05:30 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Dec 19 13:05:30 volumio dbus-daemon[541]: [system] Successfully activated service 'org.freedesktop.timedate1'
Dec 19 13:05:30 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Dec 19 13:05:30 volumio setdatetime-helper.sh[30068]: Time is already synchronized.
Dec 19 13:05:30 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Dec 19 13:05:30 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Dec 19 13:05:39 volumio volumio[27700]: Searching all installed plugins
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: , search
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: last_100 , search
Dec 19 13:05:39 volumio volumio[27700]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 19 13:05:39 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search
Dec 19 13:05:43 volumio volumio[27700]: info: [ytmusic] Innertube support service: Deno not installed or otherwise failed to start: Command failed: npx --no-install --yes deno --version
Dec 19 13:05:43 volumio volumio[27700]: info: [ytmusic] Innertube support service: Start service with Node
Dec 19 13:05:44 volumio volumio[27700]: info: CorePlayQueue::getTrack 0
Dec 19 13:05:44 volumio volumio[27700]: info: CorePlayQueue::getTrack 1
Dec 19 13:05:44 volumio volumio[27700]: Searching all installed plugins
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: , search
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: mpd , search
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , search
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: last_100 , search
Dec 19 13:05:44 volumio volumio[27700]: info: Error : CoreCommandRouter::executeOnPlugin: No method [search] in plugin last_100
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: webradio , search
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: youtube2 , search
Dec 19 13:05:44 volumio volumio[27700]: info: CoreCommandRouter::executeOnPlugin: ytmusic , search
Dec 19 13:05:44 volumio volumio[27700]: Upnp client error: Error: This socket has been ended by the other party
Dec 19 13:05:44 volumio volumio[27700]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 19 13:05:44 volumio volumio[27700]: TypeError: Cannot read properties of undefined (reading 'length')
Dec 19 13:05:44 volumio volumio[27700]: at /volumio/node_modules/libxmljs/dist/lib/parse.js:186:126
Dec 19 13:05:44 volumio volumio[27700]: at Object.parseXml (/volumio/node_modules/libxmljs/dist/lib/parse.js:185:49)
Dec 19 13:05:44 volumio volumio[27700]: at /volumio/app/plugins/music_service/webradio/index.js:949:31
Dec 19 13:05:44 volumio volumio[27700]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
Dec 19 13:05:44 volumio volumio[27700]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Dec 19 13:05:44 volumio sudo[30177]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-19 13:04'
Dec 19 13:05:44 volumio sudo[30177]: 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="fd567ba9bc0dc34c0403e2d5b72a0f46467d1983"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Fri May 23 08:02:06 UTC 2025"
VOLUMIO_VERSION="0.069"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="76fa67e30b28261e1dc7c3a89e610b9e"