Sep 05 22:34:01 volumio volumio[1078]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory
Sep 05 22:34:02 volumio volumio-remote-updater[546]: [2025-09-05 22:34:02] [connect] Successful connection
Sep 05 22:34:03 volumio volumio-remote-updater[546]: [2025-09-05 22:34:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=3&transport=websocket&t=1757079242 101
Sep 05 22:34:03 volumio volumio[1078]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 3 Transport: websocket Total Clients: 110
Sep 05 22:34:03 volumio volumio[1078]: info: JP_Radio::Updating program listings
Sep 05 22:34:04 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
Sep 05 22:34:04 volumio dbus-daemon[521]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.22' (uid=0 pid=1474 comm="timedatectl show --property=NTPSynchronized --valu")
Sep 05 22:34:04 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
Sep 05 22:34:05 volumio dbus-daemon[521]: [system] Successfully activated service 'org.freedesktop.timedate1'
Sep 05 22:34:05 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
Sep 05 22:34:05 volumio setdatetime-helper.sh[1473]: Time is already synchronized.
Sep 05 22:34:05 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
Sep 05 22:34:05 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
Sep 05 22:34:13 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Sep 05 22:34:13 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 05 22:34:13 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Sep 05 22:34:13 volumio volumio[1078]: error: Plugin music_service jp_radio failed to complete 'onStart' in a timely fashion
Sep 05 22:34:13 volumio volumio[1078]: info: -------------------------------------------
Sep 05 22:34:13 volumio volumio[1078]: info: ----- MyVolumio plugins startup ----
Sep 05 22:34:13 volumio volumio[1078]: info: -------------------------------------------
Sep 05 22:34:13 volumio volumio[1078]: info: [MyVolumio PluginManager] Fetching plans data....
Sep 05 22:34:35 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
Sep 05 22:34:38 volumio volumio[1078]: error: MyVolumio Plugin failed to start in a timely fashion
Sep 05 22:34:38 volumio volumio[1078]: [Metrics] CommandRouter: 87s 98.19ms
Sep 05 22:34:38 volumio volumio[1078]: info: CoreCommandRouter::volumiosetStartupVolume
Sep 05 22:34:38 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Sep 05 22:34:38 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Sep 05 22:34:39 volumio volumio[1078]: info: CoreCommandRouter::Close All Modals sent
Sep 05 22:34:39 volumio volumio[1078]: info: CoreCommandRouter::Close All Modals sent
Sep 05 22:34:52 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
Sep 05 22:34:52 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
Sep 05 22:34:52 volumio volumio[1078]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
Sep 05 22:34:52 volumio volumio[1078]: info: BOOT COMPLETED
Sep 05 22:35:07 volumio volumio[1078]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 05 22:35:07 volumio volumio[1078]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals.
Sep 05 22:35:07 volumio volumio[1078]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues
Sep 05 22:35:07 volumio volumio[1078]: at new NodeError (node:internal/errors:405:5)
Sep 05 22:35:07 volumio volumio[1078]: at assert (node:internal/assert:14:11)
Sep 05 22:35:07 volumio volumio[1078]: at internalConnectMultiple (node:net:1118:3)
Sep 05 22:35:07 volumio volumio[1078]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3)
Sep 05 22:35:07 volumio volumio[1078]: at listOnTimeout (node:internal/timers:575:11)
Sep 05 22:35:07 volumio volumio[1078]: at process.processTimers (node:internal/timers:514:7) {
Sep 05 22:35:07 volumio volumio[1078]: code: 'ERR_INTERNAL_ASSERTION'
Sep 05 22:35:07 volumio volumio[1078]: }
Sep 05 22:35:07 volumio volumio[1078]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Sep 05 22:35:10 volumio sudo[1612]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-09-05 22:34'
Sep 05 22:35:10 volumio sudo[1612]: 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="dfc7bb04e09bf2260691765a2340814af1fa2971"
VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6"
VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a"
VOLUMIO_BE_VERSION="30d63a8c53d2826bd7f262e22b4e4511a4cc9d01"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Sat Aug 30 06:39:32 UTC 2025"
VOLUMIO_VERSION="4.022"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="e7b0bd0cb5661ea77402e5bd121ec64a"