May 28 09:01:02 volumio volumio[1316]: info: Shairport-Sync Started
May 28 09:01:02 volumio volumio[1316]: info: Received Get System Info
May 28 09:01:02 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 09:01:02 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 09:01:02 volumio volumio[1316]: info: Discovery: Getting this device information
May 28 09:01:02 volumio volumio[1316]: info: CoreCommandRouter::volumioGetState
May 28 09:01:02 volumio volumio[1316]: info: CorePlayQueue::getTrack 0
May 28 09:01:02 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 09:01:03 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
May 28 09:01:03 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
May 28 09:01:03 volumio volumio5-onboarding[1613]: time=2026-05-28T09:01:03.751+02:00 level=INFO msg="enabling local network discovery"
May 28 09:01:03 volumio volumio5-onboarding[1613]: time=2026-05-28T09:01:03.811+02:00 level=INFO msg="enabling BLE discovery"
May 28 09:01:04 volumio volumio5-onboarding[1613]: time=2026-05-28T09:01:04.811+02:00 level=INFO msg="service successfully established" component=discovery/localnet
May 28 09:01:05 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 28 09:01:05 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 28 09:01:05 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 28 09:01:08 volumio volumio[1316]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates
May 28 09:01:08 volumio volumio[1316]: info: Received Get System Version
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 28 09:01:08 volumio volumio[1316]: info: Received Get System Info
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
May 28 09:01:08 volumio volumio[1316]: info: Discovery: Getting this device information
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::volumioGetState
May 28 09:01:08 volumio volumio[1316]: info: CorePlayQueue::getTrack 0
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: my_volumio , setMyVolumioToken
May 28 09:01:08 volumio volumio[1316]: error: MyVolumio Plugin failed to start in a timely fashion
May 28 09:01:08 volumio volumio[1316]: [Metrics] CommandRouter: 63s 891.92ms
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::volumiosetStartupVolume
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::Close All Modals sent
May 28 09:01:08 volumio volumio[1316]: info: CoreCommandRouter::Close All Modals sent
May 28 09:01:09 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard
May 28 09:01:09 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 28 09:01:09 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 28 09:01:10 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 28 09:01:27 volumio volumio[1316]: info: BOOT COMPLETED
May 28 09:01:53 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings
May 28 09:01:53 volumio volumio[1316]: info: CoreCommandRouter::getUIConfigOnPlugin
May 28 09:01:53 volumio volumio[1316]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 28 09:02:16 volumio volumio[1316]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 09:02:16 volumio volumio[1316]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals.
May 28 09:02:16 volumio volumio[1316]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues
May 28 09:02:16 volumio volumio[1316]: at new NodeError (node:internal/errors:405:5)
May 28 09:02:16 volumio volumio[1316]: at assert (node:internal/assert:14:11)
May 28 09:02:16 volumio volumio[1316]: at internalConnectMultiple (node:net:1118:3)
May 28 09:02:16 volumio volumio[1316]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3)
May 28 09:02:16 volumio volumio[1316]: at listOnTimeout (node:internal/timers:575:11)
May 28 09:02:16 volumio volumio[1316]: at process.processTimers (node:internal/timers:514:7) {
May 28 09:02:16 volumio volumio[1316]: code: 'ERR_INTERNAL_ASSERTION'
May 28 09:02:16 volumio volumio[1316]: }
May 28 09:02:16 volumio volumio[1316]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 28 09:02:28 volumio sudo[1922]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-05-28 09:01'
May 28 09:02:28 volumio sudo[1922]: 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="18952480e8d8c63f22208e9007a0f47a9563eae6"
VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd"
VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2"
VOLUMIO_BE_VERSION="0e58f1861fa88e02087981b8d91f7511f0e7011b"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Tue Mar 24 17:20:52 UTC 2026"
VOLUMIO_VERSION="4.119"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="d0c2fd9dbc5e70e58c32413c12353563"