Dec 25 18:18:35 volumio volumio[1425]: info: CoreCommandRouter::Close All Modals sent Dec 25 18:18:35 volumio volumio[1425]: info: CorePlayQueue::getTrack 1 Dec 25 18:18:35 volumio volumio[1425]: info: CorePlayQueue::getTrack 2 Dec 25 18:18:38 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 18:18:38 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 25 18:18:41 volumio volumio[1425]: info: Dec 25 18:18:41 volumio volumio[1425]: ---------------------------- MPD announces state update: player Dec 25 18:18:41 volumio volumio[1425]: info: ControllerMpd::getState Dec 25 18:18:41 volumio volumio[1425]: verbose: ControllerMpd::sendMpdCommand status Dec 25 18:18:41 volumio volumio[1425]: info: Dec 25 18:18:41 volumio volumio[1425]: ---------------------------- MPD announces state update: player Dec 25 18:18:41 volumio volumio[1425]: info: ControllerMpd::getState Dec 25 18:18:41 volumio volumio[1425]: verbose: ControllerMpd::sendMpdCommand status Dec 25 18:18:41 volumio volumio[1425]: info: Dec 25 18:18:41 volumio volumio[1425]: ---------------------------- MPD announces state update: player Dec 25 18:18:41 volumio volumio[1425]: info: ControllerMpd::getState Dec 25 18:18:41 volumio volumio[1425]: verbose: ControllerMpd::sendMpdCommand status Dec 25 18:18:41 volumio volumio[1425]: info: sendMpdCommand status took 0 milliseconds Dec 25 18:18:41 volumio volumio[1425]: verbose: ControllerMpd::parseState Dec 25 18:18:41 volumio volumio[1425]: info: ControllerMpd::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::servicePushState Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 1 Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 1 Dec 25 18:18:41 volumio volumio[1425]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 25 18:18:41 volumio volumio[1425]: verbose: CURRENT POSITION 1 Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::syncState stateService stop Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::syncState currentStatus play Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::stPlaybackTimer Dec 25 18:18:41 volumio volumio[1425]: info: ------------------------------ 3ms Dec 25 18:18:41 volumio volumio[1425]: info: sendMpdCommand status took 4 milliseconds Dec 25 18:18:41 volumio volumio[1425]: info: sendMpdCommand status took 4 milliseconds Dec 25 18:18:41 volumio volumio[1425]: verbose: ControllerMpd::parseState Dec 25 18:18:41 volumio volumio[1425]: verbose: ControllerMpd::parseState Dec 25 18:18:41 volumio volumio[1425]: info: ControllerMpd::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::servicePushState Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 25 18:18:41 volumio volumio[1425]: verbose: CURRENT POSITION 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::syncState stateService stop Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::syncState currentStatus stop Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: No code Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: ControllerMpd::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::servicePushState Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: verbose: STATE SERVICE {"status":"stop","position":null,"seek":null,"duration":null,"samplerate":null,"bitdepth":null,"channels":null,"random":false,"updatedb":false,"repeat":false,"bitrate":null,"isStreaming":false,"title":null,"artist":null,"album":null,"uri":null} Dec 25 18:18:41 volumio volumio[1425]: verbose: CURRENT POSITION 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::syncState stateService stop Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::syncState currentStatus stop Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: No code Dec 25 18:18:41 volumio volumio[1425]: info: CoreStateMachine::pushState Dec 25 18:18:41 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:18:41 volumio volumio[1425]: info: CoreCommandRouter::volumioPushState Dec 25 18:18:41 volumio volumio[1425]: info: ------------------------------ 11ms Dec 25 18:18:41 volumio volumio[1425]: info: ------------------------------ 11ms Dec 25 18:18:57 volumio volumio[1425]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ferrum_streaming_control_technology/volumio/bookworm/amd64 Dec 25 18:18:59 volumio volumio[1425]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ferrum_streaming_control_technology/volumio/bookworm/amd64 Dec 25 18:18:59 volumio volumio[1425]: info: Folder /tmp/plugins removed Dec 25 18:18:59 volumio volumio[1425]: info: Check plugin dependencies Dec 25 18:18:59 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 18:18:59 volumio volumio[1425]: info: Checking if plugin already exists Dec 25 18:18:59 volumio volumio[1425]: info: Rename folder Dec 25 18:18:59 volumio volumio[1425]: info: Folder /tmp/downloaded_plugin.zip removed Dec 25 18:18:59 volumio volumio[1425]: info: Move to category Dec 25 18:18:59 volumio volumio[1425]: info: Checking if install.sh is present Dec 25 18:18:59 volumio volumio[1425]: info: Executing install.sh Dec 25 18:18:59 volumio sudo[5712]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/sh /data/plugins/user_interface/ferrum_streaming_control_technology/install.sh Dec 25 18:18:59 volumio sudo[5712]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Dec 25 18:18:59 volumio sudo[5712]: pam_unix(sudo:session): session closed for user root Dec 25 18:18:59 volumio volumio[1425]: info: Installing ferrum streaming control technology Dependencies Dec 25 18:18:59 volumio volumio[1425]: Plugin install end detected on script Dec 25 18:18:59 volumio volumio[1425]: info: Install script completed Dec 25 18:18:59 volumio volumio[1425]: info: Adding reference to registry Dec 25 18:18:59 volumio volumio[1425]: info: Done installing plugin. Dec 25 18:18:59 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Dec 25 18:18:59 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Dec 25 18:18:59 volumio volumio[1425]: info: Folder /tmp/plugins removed Dec 25 18:18:59 volumio volumio[1425]: info: Folder /tmp/downloaded_plugin.zip removed Dec 25 18:18:59 volumio volumio[1425]: info: Folder /data/temp removed Dec 25 18:19:01 volumio volumio[1425]: info: Enabling plugin ferrum_streaming_control_technology Dec 25 18:19:01 volumio volumio[1425]: info: Loading plugin "ferrum_streaming_control_technology"... Dec 25 18:19:01 volumio volumio[1425]: error: !!!! WARNING !!!! Dec 25 18:19:01 volumio volumio[1425]: error: The plugin user_interface/ferrum_streaming_control_technology failed to load, setting it to stopped. Error: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Dec 25 18:19:01 volumio volumio[1425]: Require stack: Dec 25 18:19:01 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Dec 25 18:19:01 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Dec 25 18:19:01 volumio volumio[1425]: - /volumio/app/pluginmanager.js Dec 25 18:19:01 volumio volumio[1425]: - /volumio/app/index.js Dec 25 18:19:01 volumio volumio[1425]: - /volumio/index.js Dec 25 18:19:01 volumio volumio[1425]: error: Stack trace: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Dec 25 18:19:01 volumio volumio[1425]: Require stack: Dec 25 18:19:01 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Dec 25 18:19:01 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Dec 25 18:19:01 volumio volumio[1425]: - /volumio/app/pluginmanager.js Dec 25 18:19:01 volumio volumio[1425]: - /volumio/app/index.js Dec 25 18:19:01 volumio volumio[1425]: - /volumio/index.js Dec 25 18:19:01 volumio volumio[1425]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Dec 25 18:19:01 volumio volumio[1425]: at Module._load (node:internal/modules/cjs/loader:901:27) Dec 25 18:19:01 volumio volumio[1425]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 25 18:19:01 volumio volumio[1425]: at require (node:internal/modules/helpers:130:18) Dec 25 18:19:01 volumio volumio[1425]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js:190:31) Dec 25 18:19:01 volumio volumio[1425]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 25 18:19:01 volumio volumio[1425]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 25 18:19:01 volumio volumio[1425]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 25 18:19:01 volumio volumio[1425]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 25 18:19:01 volumio volumio[1425]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 25 18:19:01 volumio volumio[1425]: at require (node:internal/modules/helpers:130:18) Dec 25 18:19:01 volumio volumio[1425]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:25:118) Dec 25 18:19:01 volumio volumio[1425]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 25 18:19:01 volumio volumio[1425]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 25 18:19:01 volumio volumio[1425]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 25 18:19:01 volumio volumio[1425]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 25 18:19:01 volumio volumio[1425]: error: !!!! WARNING !!!! Dec 25 18:19:01 volumio volumio[1425]: info: Done. Dec 25 18:19:10 volumio volumio[1425]: info: Enabling plugin ferrum_streaming_control_technology Dec 25 18:19:10 volumio volumio[1425]: info: Loading plugin "ferrum_streaming_control_technology"... Dec 25 18:19:10 volumio volumio[1425]: error: !!!! WARNING !!!! Dec 25 18:19:10 volumio volumio[1425]: error: The plugin user_interface/ferrum_streaming_control_technology failed to load, setting it to stopped. Error: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Dec 25 18:19:10 volumio volumio[1425]: Require stack: Dec 25 18:19:10 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Dec 25 18:19:10 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Dec 25 18:19:10 volumio volumio[1425]: - /volumio/app/pluginmanager.js Dec 25 18:19:10 volumio volumio[1425]: - /volumio/app/index.js Dec 25 18:19:10 volumio volumio[1425]: - /volumio/index.js Dec 25 18:19:10 volumio volumio[1425]: error: Stack trace: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Dec 25 18:19:10 volumio volumio[1425]: Require stack: Dec 25 18:19:10 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Dec 25 18:19:10 volumio volumio[1425]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Dec 25 18:19:10 volumio volumio[1425]: - /volumio/app/pluginmanager.js Dec 25 18:19:10 volumio volumio[1425]: - /volumio/app/index.js Dec 25 18:19:10 volumio volumio[1425]: - /volumio/index.js Dec 25 18:19:10 volumio volumio[1425]: at Module._resolveFilename (node:internal/modules/cjs/loader:1048:15) Dec 25 18:19:10 volumio volumio[1425]: at Module._load (node:internal/modules/cjs/loader:901:27) Dec 25 18:19:10 volumio volumio[1425]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 25 18:19:10 volumio volumio[1425]: at require (node:internal/modules/helpers:130:18) Dec 25 18:19:10 volumio volumio[1425]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js:190:31) Dec 25 18:19:10 volumio volumio[1425]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 25 18:19:10 volumio volumio[1425]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 25 18:19:10 volumio volumio[1425]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 25 18:19:10 volumio volumio[1425]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 25 18:19:10 volumio volumio[1425]: at Module.require (node:internal/modules/cjs/loader:1115:19) Dec 25 18:19:10 volumio volumio[1425]: at require (node:internal/modules/helpers:130:18) Dec 25 18:19:10 volumio volumio[1425]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:25:118) Dec 25 18:19:10 volumio volumio[1425]: at Module._compile (node:internal/modules/cjs/loader:1233:14) Dec 25 18:19:10 volumio volumio[1425]: at Module._extensions..js (node:internal/modules/cjs/loader:1287:10) Dec 25 18:19:10 volumio volumio[1425]: at Module.load (node:internal/modules/cjs/loader:1091:32) Dec 25 18:19:10 volumio volumio[1425]: at Module._load (node:internal/modules/cjs/loader:938:12) Dec 25 18:19:10 volumio volumio[1425]: error: !!!! WARNING !!!! Dec 25 18:19:10 volumio volumio[1425]: info: Error: TypeError: Cannot read properties of null (reading 'printToastMessage') Dec 25 18:19:17 volumio volumio[1425]: info: CoreCommandRouter::volumioGetState Dec 25 18:19:17 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:19:20 volumio volumio[1425]: info: CoreCommandRouter::volumioGetState Dec 25 18:19:20 volumio volumio[1425]: info: CorePlayQueue::getTrack 0 Dec 25 18:19:23 volumio volumio[1425]: info: CoreCommandRouter::getUIConfigOnPlugin Dec 25 18:19:23 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 25 18:19:23 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 25 18:19:23 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Dec 25 18:19:23 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: appearance , getAvailableUIs Dec 25 18:19:23 volumio volumio[1425]: info: Received Get System Version Dec 25 18:19:23 volumio volumio[1425]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 25 18:19:27 volumio volumio-remote-updater[982]: Test mode disabled Dec 25 18:19:27 volumio volumio-remote-updater[982]: Alpha mode disabled Dec 25 18:19:27 volumio volumio-remote-updater[982]: Alpha legacy test mode disabled Dec 25 18:19:27 volumio volumio[1425]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 18:19:27 volumio volumio[1425]: TypeError: Cannot read properties of null (reading 'broadcastMessage') Dec 25 18:19:27 volumio volumio[1425]: at /volumio/app/index.js:1534:32 Dec 25 18:19:27 volumio volumio[1425]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Dec 25 18:19:27 volumio volumio[1425]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Dec 25 18:19:27 volumio volumio[1425]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Dec 25 18:19:27 volumio volumio[1425]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:938:26) Dec 25 18:19:27 volumio volumio[1425]: at Socket.emit (node:events:514:28) Dec 25 18:19:27 volumio volumio[1425]: at /volumio/node_modules/socket.io/lib/socket.js:503:12 Dec 25 18:19:27 volumio volumio[1425]: at process.processTicksAndRejections (node:internal/process/task_queues:77:11) Dec 25 18:19:27 volumio volumio[1425]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 25 18:19:27 volumio sudo[5827]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2025-12-25 18:18' Dec 25 18:19:27 volumio sudo[5827]: 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="cfdc872d40b979cca36352a7333c940c38dc64b5" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="6cbc2303e10f00c3a01cb7f02c6d12448bd32c62" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri Dec 5 21:07:15 UTC 2025" VOLUMIO_VERSION="4.073" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="4b5c74f40f473b90a542bf010b97924b"