-- Logs begin at Fri 2025-10-24 14:52:18 UTC, end at Fri 2025-10-24 15:04:25 UTC. -- Oct 24 15:03:01 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:01 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:01 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:01 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:01 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:01 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:01 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:07 volumio volumio[1175]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/amd64 Oct 24 15:03:07 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:03:07 volumio volumio[1175]: info: An error occurred installing the plugin. Rolling back config Oct 24 15:03:07 volumio volumio[1175]: info: Plugin folders cleanup Oct 24 15:03:07 volumio volumio[1175]: info: Scanning into folder /volumio/app/plugins/ Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category audio_interface Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category miscellanea Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category music_service Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category plugins.json Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category system_controller Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category user_interface Oct 24 15:03:07 volumio volumio[1175]: info: Scanning into folder /data/plugins/ Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category audio_interface Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category music_service Oct 24 15:03:07 volumio volumio[1175]: info: Scanning category system_controller Oct 24 15:03:07 volumio volumio[1175]: info: Plugin folders cleanup completed Oct 24 15:03:07 volumio volumio[1175]: info: Error: Error Oct 24 15:03:07 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:03:07 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:03:07 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:03:07 volumio volumio[1175]: info: Folder /data/temp removed Oct 24 15:03:07 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 24 15:03:07 volumio volumio[1175]: info: CorePlayQueue::getTrack 2 Oct 24 15:03:13 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 24 15:03:13 volumio volumio[1175]: info: CorePlayQueue::getTrack 2 Oct 24 15:03:14 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 15:03:14 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 24 15:03:15 volumio volumio[1175]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/amd64 Oct 24 15:03:15 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:03:15 volumio volumio[1175]: info: An error occurred installing the plugin. Rolling back config Oct 24 15:03:15 volumio volumio[1175]: info: Plugin folders cleanup Oct 24 15:03:15 volumio volumio[1175]: info: Scanning into folder /volumio/app/plugins/ Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category audio_interface Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category miscellanea Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category music_service Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category plugins.json Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category system_controller Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category user_interface Oct 24 15:03:15 volumio volumio[1175]: info: Scanning into folder /data/plugins/ Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category audio_interface Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category music_service Oct 24 15:03:15 volumio volumio[1175]: info: Scanning category system_controller Oct 24 15:03:15 volumio volumio[1175]: info: Plugin folders cleanup completed Oct 24 15:03:15 volumio volumio[1175]: info: Error: Error Oct 24 15:03:15 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:03:15 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:03:15 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:03:15 volumio volumio[1175]: info: Folder /data/temp removed Oct 24 15:03:29 volumio volumio[1175]: info: 0 upgraded, 1 newly installed, 0 to remove and 0 not upgraded. Oct 24 15:03:29 volumio volumio[1175]: info: Need to get 143 kB of archives. Oct 24 15:03:29 volumio volumio[1175]: info: After this operation, 609 kB of additional disk space will be used. Oct 24 15:03:29 volumio volumio[1175]: info: Err:1 http://archive.debian.org/debian buster/main amd64 drc amd64 3.2.2~dfsg0-2 Oct 24 15:03:29 volumio volumio[1175]: info: Something wicked happened resolving 'archive.debian.org:http' (-5 - No address associated with hostname) Oct 24 15:03:29 volumio sudo[4656]: pam_unix(sudo:session): session closed for user root Oct 24 15:03:29 volumio sudo[3938]: pam_unix(sudo:session): session closed for user root Oct 24 15:03:29 volumio volumio[1175]: Plugin install end detected on script Oct 24 15:03:29 volumio volumio[1175]: info: Install script completed Oct 24 15:03:29 volumio volumio[1175]: info: Adding reference to registry Oct 24 15:03:29 volumio volumio[1175]: info: Done installing plugin. Oct 24 15:03:29 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 15:03:29 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 24 15:03:29 volumio volumio[1175]: info: Folder /data/temp removed Oct 24 15:03:29 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:03:29 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:03:34 volumio volumio[1175]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Oct 24 15:03:34 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 24 15:03:34 volumio volumio[1175]: info: CorePlayQueue::getTrack 2 Oct 24 15:03:34 volumio volumio[1175]: SPOTIFY: RECEIVED VOLUMIO VOLUME 10 Oct 24 15:03:36 volumio volumio[1175]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/amd64 Oct 24 15:03:39 volumio volumio[1175]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/mpdoutput/volumio/buster/amd64 Oct 24 15:03:39 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:03:39 volumio volumio[1175]: info: Check plugin dependencies Oct 24 15:03:39 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 15:03:39 volumio volumio[1175]: info: Checking if plugin already exists Oct 24 15:03:39 volumio volumio[1175]: info: Rename folder Oct 24 15:03:39 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:03:39 volumio volumio[1175]: info: Move to category Oct 24 15:03:39 volumio volumio[1175]: info: Checking if install.sh is present Oct 24 15:03:39 volumio volumio[1175]: info: Executing install.sh Oct 24 15:03:39 volumio sudo[4942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/mpdoutput/install.sh Oct 24 15:03:39 volumio sudo[4942]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 15:03:39 volumio sudo[4942]: pam_unix(sudo:session): session closed for user root Oct 24 15:03:39 volumio volumio[1175]: info: Installing mpd http output Oct 24 15:03:39 volumio volumio[1175]: Plugin install end detected on script Oct 24 15:03:39 volumio volumio[1175]: info: Install script completed Oct 24 15:03:39 volumio volumio[1175]: info: Adding reference to registry Oct 24 15:03:39 volumio volumio[1175]: info: Done installing plugin. Oct 24 15:03:39 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 15:03:39 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 24 15:03:39 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:03:39 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:03:39 volumio volumio[1175]: info: Folder /data/temp removed Oct 24 15:03:40 volumio ntpd[1244]: Soliciting pool server 160.187.147.197 Oct 24 15:03:40 volumio volumio[1175]: info: Enabling plugin mpdoutput Oct 24 15:03:40 volumio volumio[1175]: info: Loading plugin "mpdoutput"... Oct 24 15:03:40 volumio volumio[1175]: info: PLUGIN START: mpdoutput Oct 24 15:03:40 volumio volumio[1175]: info: Done. Oct 24 15:03:41 volumio ntpd[1244]: Soliciting pool server 103.121.88.11 Oct 24 15:03:44 volumio ntpd[1244]: Soliciting pool server 2404:fbc0:0:21ef::a Oct 24 15:04:00 volumio volumio[1175]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ferrum_streaming_control_technology/volumio/buster/amd64 Oct 24 15:04:16 volumio volumio[1175]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/ferrum_streaming_control_technology/volumio/buster/amd64 Oct 24 15:04:16 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:04:16 volumio volumio[1175]: info: Check plugin dependencies Oct 24 15:04:16 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 24 15:04:16 volumio volumio[1175]: info: Checking if plugin already exists Oct 24 15:04:16 volumio volumio[1175]: info: Rename folder Oct 24 15:04:16 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:04:16 volumio volumio[1175]: info: Move to category Oct 24 15:04:16 volumio volumio[1175]: info: Checking if install.sh is present Oct 24 15:04:16 volumio volumio[1175]: info: Executing install.sh Oct 24 15:04:16 volumio sudo[5096]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/ferrum_streaming_control_technology/install.sh Oct 24 15:04:16 volumio sudo[5096]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 24 15:04:16 volumio sudo[5096]: pam_unix(sudo:session): session closed for user root Oct 24 15:04:16 volumio volumio[1175]: info: Installing ferrum streaming control technology Dependencies Oct 24 15:04:16 volumio volumio[1175]: Plugin install end detected on script Oct 24 15:04:16 volumio volumio[1175]: info: Install script completed Oct 24 15:04:16 volumio volumio[1175]: info: Adding reference to registry Oct 24 15:04:16 volumio volumio[1175]: info: Done installing plugin. Oct 24 15:04:16 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 15:04:16 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 24 15:04:16 volumio volumio[1175]: info: Folder /tmp/plugins removed Oct 24 15:04:16 volumio volumio[1175]: info: Folder /tmp/downloaded_plugin.zip removed Oct 24 15:04:16 volumio volumio[1175]: info: Folder /data/temp removed Oct 24 15:04:20 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 24 15:04:20 volumio volumio[1175]: info: Received Get System Info Oct 24 15:04:20 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 24 15:04:20 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 24 15:04:20 volumio volumio[1175]: info: Discovery: Getting this device information Oct 24 15:04:20 volumio volumio[1175]: info: CoreCommandRouter::volumioGetState Oct 24 15:04:20 volumio volumio[1175]: info: CorePlayQueue::getTrack 2 Oct 24 15:04:20 volumio volumio[1175]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 24 15:04:23 volumio volumio[1175]: info: Enabling plugin ferrum_streaming_control_technology Oct 24 15:04:23 volumio volumio[1175]: info: Loading plugin "ferrum_streaming_control_technology"... Oct 24 15:04:25 volumio volumio[1175]: error: !!!! WARNING !!!! Oct 24 15:04:25 volumio volumio[1175]: 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' Oct 24 15:04:25 volumio volumio[1175]: Require stack: Oct 24 15:04:25 volumio volumio[1175]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Oct 24 15:04:25 volumio volumio[1175]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Oct 24 15:04:25 volumio volumio[1175]: - /volumio/app/pluginmanager.js Oct 24 15:04:25 volumio volumio[1175]: - /volumio/app/index.js Oct 24 15:04:25 volumio volumio[1175]: - /volumio/index.js Oct 24 15:04:25 volumio volumio[1175]: error: Stack trace: Error: Cannot find module '@hemspzoo/fsct-lib-linux-x64-gnu' Oct 24 15:04:25 volumio volumio[1175]: Require stack: Oct 24 15:04:25 volumio volumio[1175]: - /data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js Oct 24 15:04:25 volumio volumio[1175]: - /data/plugins/user_interface/ferrum_streaming_control_technology/index.js Oct 24 15:04:25 volumio volumio[1175]: - /volumio/app/pluginmanager.js Oct 24 15:04:25 volumio volumio[1175]: - /volumio/app/index.js Oct 24 15:04:25 volumio volumio[1175]: - /volumio/index.js Oct 24 15:04:25 volumio volumio[1175]: at Function.Module._resolveFilename (internal/modules/cjs/loader.js:931:15) Oct 24 15:04:25 volumio volumio[1175]: at Function.Module._load (internal/modules/cjs/loader.js:774:27) Oct 24 15:04:25 volumio volumio[1175]: at Module.require (internal/modules/cjs/loader.js:1003:19) Oct 24 15:04:25 volumio volumio[1175]: at require (internal/modules/cjs/helpers.js:107:18) Oct 24 15:04:25 volumio volumio[1175]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/node_modules/@hemspzoo/fsct-lib/index.js:190:31) Oct 24 15:04:25 volumio volumio[1175]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Oct 24 15:04:25 volumio volumio[1175]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Oct 24 15:04:25 volumio volumio[1175]: at Module.load (internal/modules/cjs/loader.js:979:32) Oct 24 15:04:25 volumio volumio[1175]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Oct 24 15:04:25 volumio volumio[1175]: at Module.require (internal/modules/cjs/loader.js:1003:19) Oct 24 15:04:25 volumio volumio[1175]: at require (internal/modules/cjs/helpers.js:107:18) Oct 24 15:04:25 volumio volumio[1175]: at Object. (/data/plugins/user_interface/ferrum_streaming_control_technology/index.js:25:118) Oct 24 15:04:25 volumio volumio[1175]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Oct 24 15:04:25 volumio volumio[1175]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Oct 24 15:04:25 volumio volumio[1175]: at Module.load (internal/modules/cjs/loader.js:979:32) Oct 24 15:04:25 volumio volumio[1175]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Oct 24 15:04:25 volumio volumio[1175]: error: !!!! WARNING !!!! Oct 24 15:04:25 volumio volumio[1175]: info: Done. Oct 24 15:04:25 volumio volumio[1175]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 15:04:25 volumio volumio[1175]: TypeError: Cannot read property 'broadcastMessage' of null Oct 24 15:04:25 volumio volumio[1175]: at /volumio/app/index.js:1534:32 Oct 24 15:04:25 volumio volumio[1175]: at fastMap (/volumio/node_modules/fast.js/array/map.js:21:17) Oct 24 15:04:25 volumio volumio[1175]: at Function.fastMap [as map] (/volumio/node_modules/fast.js/map.js:18:12) Oct 24 15:04:25 volumio volumio[1175]: at CoreCommandRouter.broadcastMessage (/volumio/app/index.js:1532:13) Oct 24 15:04:25 volumio volumio[1175]: at Socket. (/volumio/app/plugins/system_controller/system/index.js:1555:28) Oct 24 15:04:25 volumio volumio[1175]: at Socket.emit (events.js:400:28) Oct 24 15:04:25 volumio volumio[1175]: at addChunk (internal/streams/readable.js:293:12) Oct 24 15:04:25 volumio volumio[1175]: at readableAddChunk (internal/streams/readable.js:267:9) Oct 24 15:04:25 volumio volumio[1175]: at Socket.Readable.push (internal/streams/readable.js:206:10) Oct 24 15:04:25 volumio volumio[1175]: at Pipe.onStreamRead (internal/stream_base_commons.js:188:23) Oct 24 15:04:25 volumio volumio[1175]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 24 15:04:25 volumio sudo[5185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-24 15:03 Oct 24 15:04:25 volumio sudo[5185]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="669bb6cc406bb77b11c5184fedb8a4dfd19ba4ec" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 11:08:46 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="9ef0bfa9b61509be20c9051562554f31"