May 29 14:23:02 volumio volumio[29659]: (node:29659) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit
May 29 14:23:02 volumio volumio[29659]: (Use `node --trace-warnings ...` to show where the warning was created)
May 29 14:23:04 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings
May 29 14:23:06 volumio volumio[29659]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 35
May 29 14:23:08 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 29 14:23:08 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 29 14:23:08 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam
May 29 14:23:08 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam
May 29 14:23:08 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject
May 29 14:23:08 volumio volumio[29659]: info: CoreCommandRouter::volumioGetBrowseSources
May 29 14:23:08 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
May 29 14:23:10 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: youtube2 , handleBrowseUri
May 29 14:23:10 volumio volumio[29659]: info: [youtube2-browse] browseUri: youtube2
May 29 14:23:10 volumio volumio[29659]: info: [youtube2] InnertubeLoader: creating Innertube instance...
May 29 14:23:10 volumio volumio[29659]: error: MyVolumio Plugin failed to authenticate in a timely fashion
May 29 14:23:10 volumio volumio[29659]: info: Completed starting MyVolumio Plugin
May 29 14:23:10 volumio volumio[29659]: [Metrics] CommandRouter: 90s 739.32ms
May 29 14:23:10 volumio volumio[29659]: info: CoreCommandRouter::volumiosetStartupVolume
May 29 14:23:10 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
May 29 14:23:10 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 29 14:23:10 volumio volumio[29659]: info: CoreCommandRouter::Close All Modals sent
May 29 14:23:10 volumio volumio[29659]: info: CoreCommandRouter::Close All Modals sent
May 29 14:23:11 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable
May 29 14:23:11 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus
May 29 14:23:11 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect
May 29 14:23:13 volumio volumio[29659]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN
May 29 14:23:14 volumio volumio[29659]: info: CoreCommandRouter::volumioGetState
May 29 14:23:14 volumio volumio[29659]: info: CorePlayQueue::getTrack 0
May 29 14:23:16 volumio volumio[29659]: info: CoreCommandRouter::volumioGetState
May 29 14:23:16 volumio volumio[29659]: info: CorePlayQueue::getTrack 0
May 29 14:23:19 volumio volumio[29659]: info: BOOT COMPLETED
May 29 14:23:19 volumio volumio[29659]: (node:29659) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit
May 29 14:23:20 volumio volumio[29659]: (node:29659) MaxListenersExceededWarning: Possible EventEmitter memory leak detected. 11 close listeners added to [TLSSocket]. Use emitter.setMaxListeners() to increase limit
May 29 14:23:24 volumio volumio[29659]: info: MyVolumio token set successfully
May 29 14:23:24 volumio volumio[29659]: info: MYVOLUMIO: Adding device
May 29 14:23:24 volumio volumio[29659]: info: MYVOLUMIO: Evaluating Server
May 29 14:23:26 volumio volumio[29659]: info: MyVolumio status changed
May 29 14:23:26 volumio volumio[29659]: info: Streaming services startup
May 29 14:23:26 volumio volumio[29659]: info: Starting Streaming Daemon
May 29 14:23:26 volumio volumio[29659]: info: Removing browser output: myVolumio user plan is not superstar
May 29 14:23:26 volumio volumio[29659]: info: Removing audio output:
May 29 14:23:26 volumio volumio[29659]: info: Stoppping Tunnel 1
May 29 14:23:26 volumio sudo[30095]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service
May 29 14:23:26 volumio sudo[30095]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 29 14:23:26 volumio sudo[30097]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop sshtunnel.service
May 29 14:23:26 volumio sudo[30097]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000)
May 29 14:23:26 volumio systemd[1]: Starting setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service...
May 29 14:23:26 volumio sudo[30095]: pam_unix(sudo:session): session closed for user root
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:6: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio sudo[30097]: pam_unix(sudo:session): session closed for user root
May 29 14:23:26 volumio systemd[1]: /lib/systemd/system/sshtunnel.service:7: Standard output type syslog is obsolete, automatically updating to journal. Please update your unit file, and consider removing the setting altogether.
May 29 14:23:26 volumio dbus-daemon[573]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' requested by ':1.285' (uid=0 pid=30101 comm="timedatectl show --property=NTPSynchronized --valu")
May 29 14:23:26 volumio systemd[1]: Starting systemd-timedated.service - Time & Date Service...
May 29 14:23:27 volumio dbus-daemon[573]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 29 14:23:27 volumio systemd[1]: Started systemd-timedated.service - Time & Date Service.
May 29 14:23:27 volumio setdatetime-helper.sh[30100]: Time is already synchronized.
May 29 14:23:27 volumio systemd[1]: setdatetime-helper.timer.service: Deactivated successfully.
May 29 14:23:27 volumio systemd[1]: Finished setdatetime-helper.timer.service - Volumio Time Sync Watchdog Service.
May 29 14:23:29 volumio volumio[29659]: info: Setting Geolocation for MyVolumio to as1
May 29 14:23:29 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 29 14:23:29 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 29 14:23:29 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 29 14:23:29 volumio volumio[29659]: info: Remote SSH Stopped
May 29 14:23:29 volumio volumio[29659]: error: Cannot start Volumio Streaming Daemon
May 29 14:23:29 volumio volumio[29659]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service
May 29 14:23:29 volumio volumio[29659]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found.
May 29 14:23:30 volumio volumio[29659]: info: Updating MyVolumio device info
May 29 14:23:30 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 29 14:23:30 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 29 14:23:30 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
May 29 14:23:31 volumio volumio[29659]: info: CoreCommandRouter::volumioGetState
May 29 14:23:31 volumio volumio[29659]: info: CorePlayQueue::getTrack 0
May 29 14:23:37 volumio volumio[29659]: info: Successfully Added MyVolumio device
May 29 14:23:41 volumio volumio[29659]: info: Successfully Updated MyVolumio device
May 29 14:23:43 volumio volumio[29659]: info: CoreCommandRouter::volumioGetState
May 29 14:23:43 volumio volumio[29659]: info: CorePlayQueue::getTrack 0
May 29 14:23:47 volumio volumio[29659]: error: fetch failed TypeError: fetch failed
May 29 14:23:47 volumio volumio[29659]: at fetch (/data/plugins/music_service/youtube2/node_modules/undici/index.js:112:15)
May 29 14:23:47 volumio volumio[29659]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 29 14:23:47 volumio volumio[29659]: at async Player.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:26349:19)
May 29 14:23:47 volumio volumio[29659]: at async Session.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:26600:123)
May 29 14:23:47 volumio volumio[29659]: at async Innertube.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:31752:26)
May 29 14:23:47 volumio volumio[29659]: at async InnertubeLoader._InnertubeLoader_createInstance (/data/plugins/music_service/youtube2/dist/lib/model/InnertubeLoader.js:144:23)
May 29 14:23:47 volumio volumio[29659]: error: Failed to execute browseSource: TypeError: fetch failed
May 29 14:23:55 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus
May 29 14:23:55 volumio volumio[29659]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken
May 29 14:23:57 volumio systemd[1]: systemd-timedated.service: Deactivated successfully.
May 29 14:24:10 volumio volumio[29659]: info: CoreCommandRouter::getUIConfigOnPlugin
May 29 14:24:10 volumio volumio[29659]: error: [youtube2] Error getting i18n options: fetch failed TypeError: fetch failed
May 29 14:24:10 volumio volumio[29659]: at fetch (/data/plugins/music_service/youtube2/node_modules/undici/index.js:112:15)
May 29 14:24:10 volumio volumio[29659]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 29 14:24:10 volumio volumio[29659]: at async Player.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:26349:19)
May 29 14:24:10 volumio volumio[29659]: at async Session.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:26600:123)
May 29 14:24:10 volumio volumio[29659]: at async Innertube.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:31752:26)
May 29 14:24:10 volumio volumio[29659]: at async InnertubeLoader._InnertubeLoader_createInstance (/data/plugins/music_service/youtube2/dist/lib/model/InnertubeLoader.js:144:23)
May 29 14:24:10 volumio volumio[29659]: error: [youtube2] getUIConfig(): Cannot populate YouTube2 configuration: fetch failed TypeError: fetch failed
May 29 14:24:10 volumio volumio[29659]: at fetch (/data/plugins/music_service/youtube2/node_modules/undici/index.js:112:15)
May 29 14:24:10 volumio volumio[29659]: at process.processTicksAndRejections (node:internal/process/task_queues:95:5)
May 29 14:24:10 volumio volumio[29659]: at async Player.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:26349:19)
May 29 14:24:10 volumio volumio[29659]: at async Session.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:26600:123)
May 29 14:24:10 volumio volumio[29659]: at async Innertube.create (/data/plugins/music_service/youtube2/node_modules/volumio-youtubei.js/bundle/node.cjs:31752:26)
May 29 14:24:10 volumio volumio[29659]: at async InnertubeLoader._InnertubeLoader_createInstance (/data/plugins/music_service/youtube2/dist/lib/model/InnertubeLoader.js:144:23)
May 29 14:24:20 volumio volumio[29659]: info: CoreCommandRouter::volumioGetState
May 29 14:24:20 volumio volumio[29659]: info: CorePlayQueue::getTrack 0
May 29 14:24:21 volumio volumio[29659]: error: Cannot download Available plugins list: Error: ETIMEDOUT
May 29 14:24:21 volumio volumio[29659]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 29 14:24:21 volumio volumio[29659]: Error [ERR_INTERNAL_ASSERTION]: This is caused by either a bug in Node.js or incorrect usage of Node.js internals.
May 29 14:24:21 volumio volumio[29659]: Please open an issue with this stack trace at https://github.com/nodejs/node/issues
May 29 14:24:21 volumio volumio[29659]: at new NodeError (node:internal/errors:405:5)
May 29 14:24:21 volumio volumio[29659]: at assert (node:internal/assert:14:11)
May 29 14:24:21 volumio volumio[29659]: at internalConnectMultiple (node:net:1118:3)
May 29 14:24:21 volumio volumio[29659]: at Timeout.internalConnectMultipleTimeout (node:net:1687:3)
May 29 14:24:21 volumio volumio[29659]: at listOnTimeout (node:internal/timers:575:11)
May 29 14:24:21 volumio volumio[29659]: at process.processTimers (node:internal/timers:514:7) {
May 29 14:24:21 volumio volumio[29659]: code: 'ERR_INTERNAL_ASSERTION'
May 29 14:24:21 volumio volumio[29659]: }
May 29 14:24:21 volumio volumio[29659]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
May 29 14:24:22 volumio sudo[30197]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-05-29 14:23'
May 29 14:24:22 volumio sudo[30197]: 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"