Feb 25 21:18:23 volumio ntpd[892]: PROTO: 162.159.200.123 unlink local addr 192.168.0.102 -> Feb 25 21:18:25 volumio volumio[1163]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Feb 25 21:18:25 volumio volumio[1163]: info: Downloading plugin at http://127.0.0.1:3000/plugin-serve/now_playing.zip Feb 25 21:18:25 volumio volumio5-onboarding[1780]: time=2026-02-25T13:18:25.751Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 21:18:25 volumio volumio[1163]: info: END DOWNLOAD: http://127.0.0.1:3000/plugin-serve/now_playing.zip Feb 25 21:18:25 volumio volumio[1163]: info: Folder /tmp/plugins removed Feb 25 21:18:25 volumio volumio5-onboarding[1780]: time=2026-02-25T13:18:25.782Z level=WARN msg="received plugin install progress but no plugin is being installed" component=state Feb 25 21:18:25 volumio volumio[1163]: info: An error occurred installing the plugin. Rolling back config Feb 25 21:18:25 volumio volumio[1163]: info: Plugin folders cleanup Feb 25 21:18:25 volumio volumio[1163]: info: Scanning into folder /volumio/app/plugins/ Feb 25 21:18:25 volumio volumio[1163]: info: Scanning category audio_interface Feb 25 21:18:25 volumio volumio[1163]: info: Scanning category miscellanea Feb 25 21:18:25 volumio volumio[1163]: info: Scanning category music_service Feb 25 21:18:25 volumio volumio[1163]: info: Scanning category plugins.json Feb 25 21:18:25 volumio volumio[1163]: info: Scanning category system_controller Feb 25 21:18:25 volumio volumio[1163]: info: Scanning category user_interface Feb 25 21:18:25 volumio volumio[1163]: info: Scanning into folder /data/plugins/ Feb 25 21:18:25 volumio volumio[1163]: info: Scanning category user_interface Feb 25 21:18:25 volumio volumio[1163]: info: Plugin folders cleanup completed Feb 25 21:18:25 volumio volumio[1163]: info: Error: Error Feb 25 21:18:25 volumio volumio[1163]: info: Folder /data/temp removed Feb 25 21:18:25 volumio volumio[1163]: info: Folder /tmp/plugins removed Feb 25 21:18:25 volumio volumio[1163]: info: Folder /tmp/downloaded_plugin.zip removed Feb 25 21:18:41 volumio volumio[1163]: verbose: New Socket.io Connection to 192.168.0.102 from 192.168.0.179 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/145.0.0.0 Safari/537.36 Edg/145.0.0.0 Engine version: 3 Transport: polling Total Clients: 6 Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::volumioGetVisibleSources Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::volumioGetState Feb 25 21:18:41 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Feb 25 21:18:41 volumio volumio[1163]: info: Received Get System Info Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 21:18:41 volumio volumio[1163]: info: Discovery: Getting this device information Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::volumioGetState Feb 25 21:18:41 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::volumioGetState Feb 25 21:18:41 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Feb 25 21:18:41 volumio volumio[1163]: info: Listing playlists Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Feb 25 21:18:41 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Feb 25 21:18:42 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Feb 25 21:18:42 volumio volumio[1163]: info: CoreCommandRouter::volumioGetState Feb 25 21:18:42 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Feb 25 21:18:43 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Feb 25 21:18:43 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 21:18:43 volumio volumio[1163]: info: Received Get System Info Feb 25 21:18:43 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Feb 25 21:18:43 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Feb 25 21:18:43 volumio volumio[1163]: info: Discovery: Getting this device information Feb 25 21:18:43 volumio volumio[1163]: info: CoreCommandRouter::volumioGetState Feb 25 21:18:43 volumio volumio[1163]: info: CorePlayQueue::getTrack 0 Feb 25 21:18:43 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Feb 25 21:18:44 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 21:18:45 volumio volumio[1163]: info: CoreCommandRouter::Close All Modals sent Feb 25 21:18:49 volumio volumio[1163]: info: Enabling plugin now_playing Feb 25 21:18:49 volumio volumio[1163]: info: Loading plugin "now_playing"... Feb 25 21:18:49 volumio volumio[1163]: error: !!!! WARNING !!!! Feb 25 21:18:49 volumio volumio[1163]: error: The plugin user_interface/now_playing failed to load, setting it to stopped. Error: Error: Cannot find module 'geo-tz' Feb 25 21:18:49 volumio volumio[1163]: Require stack: Feb 25 21:18:49 volumio volumio[1163]: - /data/plugins/user_interface/now_playing/dist/index.js Feb 25 21:18:49 volumio volumio[1163]: - /volumio/app/pluginmanager.js Feb 25 21:18:49 volumio volumio[1163]: - /volumio/app/index.js Feb 25 21:18:49 volumio volumio[1163]: - /volumio/index.js Feb 25 21:18:49 volumio volumio[1163]: error: Stack trace: Error: Cannot find module 'geo-tz' Feb 25 21:18:49 volumio volumio[1163]: Require stack: Feb 25 21:18:49 volumio volumio[1163]: - /data/plugins/user_interface/now_playing/dist/index.js Feb 25 21:18:49 volumio volumio[1163]: - /volumio/app/pluginmanager.js Feb 25 21:18:49 volumio volumio[1163]: - /volumio/app/index.js Feb 25 21:18:49 volumio volumio[1163]: - /volumio/index.js Feb 25 21:18:49 volumio volumio[1163]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Feb 25 21:18:49 volumio volumio[1163]: at Module._load (node:internal/modules/cjs/loader:901:27) Feb 25 21:18:49 volumio volumio[1163]: at Module.require (node:internal/modules/cjs/loader:1115:19) Feb 25 21:18:49 volumio volumio[1163]: at require (node:internal/modules/helpers:130:18) Feb 25 21:18:49 volumio volumio[1163]: at Object. (/data/plugins/user_interface/now_playing/dist/index.js:46:34) Feb 25 21:18:49 volumio volumio[1163]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Feb 25 21:18:49 volumio volumio[1163]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Feb 25 21:18:49 volumio volumio[1163]: at Module.load (node:internal/modules/cjs/loader:1091:32) Feb 25 21:18:49 volumio volumio[1163]: at Module._load (node:internal/modules/cjs/loader:938:12) Feb 25 21:18:49 volumio volumio[1163]: at Module.require (node:internal/modules/cjs/loader:1115:19) Feb 25 21:18:49 volumio volumio[1163]: at require (node:internal/modules/helpers:130:18) Feb 25 21:18:49 volumio volumio[1163]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:29) Feb 25 21:18:49 volumio volumio[1163]: at Promise._successFn (/volumio/app/pluginmanager.js:1855:19) Feb 25 21:18:49 volumio volumio[1163]: at nextTickCallback (/volumio/node_modules/kew/kew.js:47:28) Feb 25 21:18:49 volumio volumio[1163]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Feb 25 21:18:49 volumio volumio[1163]: error: !!!! WARNING !!!! Feb 25 21:18:49 volumio volumio[1163]: info: Done. Feb 25 21:18:51 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Feb 25 21:18:54 volumio volumio[1163]: info: CoreCommandRouter::getUIConfigOnPlugin Feb 25 21:18:56 volumio volumio[1163]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Feb 25 21:18:57 volumio volumio[1163]: info: CoreCommandRouter::Close All Modals sent Feb 25 21:18:57 volumio volumio[1163]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 21:18:57 volumio volumio[1163]: TypeError: Cannot read properties of null (reading 'broadcastMessage') Feb 25 21:18:57 volumio volumio[1163]: at /volumio/app/index.js:1534:32 Feb 25 21:18:57 volumio volumio[1163]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Feb 25 21:18:57 volumio volumio[1163]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Feb 25 21:18:57 volumio volumio[1163]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Feb 25 21:18:57 volumio volumio[1163]: at CoreCommandRouter.closeModals (/volumio/app/index.js:1954:15) Feb 25 21:18:57 volumio volumio[1163]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1975:26) Feb 25 21:18:57 volumio volumio[1163]: at Socket.emit (node:events:514:28) Feb 25 21:18:57 volumio volumio[1163]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Feb 25 21:18:57 volumio volumio[1163]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Feb 25 21:18:57 volumio volumio[1163]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Feb 25 21:18:57 volumio sudo[5149]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-02-25 21:17' Feb 25 21:18:57 volumio sudo[5149]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Debian GNU/Linux 12 (bookworm)" NAME="Debian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="a78d359cf1dc63ac74e9d151015afd30d31a709a" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="c1ffe93b2136013fc1b5903a4ed7e3f34e0a7bec" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Feb 5 14:31:57 UTC 2026" VOLUMIO_VERSION="4.096" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="6759e875c98b942866984e844891d6c1"