-- Logs begin at Mon 2025-10-27 12:24:44 CET, end at Mon 2025-10-27 12:32:13 CET. -- Oct 27 12:31:00 km-volumio volumio[912]: info: cpuset is already the newest version (1.5.6-5.1). Oct 27 12:31:00 km-volumio sudo[3334]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:00 km-volumio volumio[912]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Oct 27 12:31:00 km-volumio sudo[3352]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/moveprocess.sh Oct 27 12:31:00 km-volumio sudo[3352]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:00 km-volumio sudo[3352]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:00 km-volumio sudo[3354]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/moveallprocesses.sh Oct 27 12:31:00 km-volumio sudo[3354]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:00 km-volumio sudo[3354]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:00 km-volumio sudo[3356]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/usertaskstable.sh Oct 27 12:31:00 km-volumio sudo[3356]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:00 km-volumio sudo[3356]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:00 km-volumio sudo[3358]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/builduiconfig.sh Oct 27 12:31:00 km-volumio sudo[3358]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:00 km-volumio sudo[3358]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:00 km-volumio sudo[3360]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/setconfigparameter.sh Oct 27 12:31:00 km-volumio sudo[3360]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:00 km-volumio sudo[3360]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:00 km-volumio sudo[3362]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/setrtpriority.sh Oct 27 12:31:00 km-volumio sudo[3362]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:00 km-volumio sudo[3362]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:00 km-volumio sudo[3364]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/addservice.sh Oct 27 12:31:00 km-volumio sudo[3364]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:00 km-volumio sudo[3364]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:01 km-volumio sudo[3366]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/system_hardware/music_services_shield/removeservice.sh Oct 27 12:31:01 km-volumio sudo[3366]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:01 km-volumio sudo[3366]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:01 km-volumio sudo[3098]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:01 km-volumio volumio[912]: Plugin install end detected on script Oct 27 12:31:01 km-volumio volumio[912]: info: Install script completed Oct 27 12:31:01 km-volumio volumio[912]: info: Done installing plugin. Oct 27 12:31:01 km-volumio volumio[912]: info: Enabling plugin music_services_shield Oct 27 12:31:01 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 12:31:01 km-volumio volumio[912]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.2.0","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.3.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"ScheduledRestart","name":"scheduledrestart","category":"system_controller","version":"0.7.2","icon":"fa-clock-o","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Music Services Shield","name":"music_services_shield","category":"system_hardware","version":"1.3.1","icon":"fa-shield","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Oct 27 12:31:01 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 27 12:31:01 km-volumio volumio[912]: info: Folder /tmp/plugins removed Oct 27 12:31:01 km-volumio volumio[912]: info: Folder /tmp/downloaded_plugin.zip removed Oct 27 12:31:01 km-volumio volumio[912]: info: Folder /data/temp removed Oct 27 12:31:03 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 12:31:03 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 12:31:03 km-volumio volumio[912]: info: Discovery: Getting this device information Oct 27 12:31:03 km-volumio volumio[912]: info: CoreCommandRouter::volumioGetState Oct 27 12:31:03 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 12:31:21 km-volumio volumio[912]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/RoonBridge/volumio/buster/amd64 Oct 27 12:31:22 km-volumio volumio[912]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/RoonBridge/volumio/buster/amd64 Oct 27 12:31:22 km-volumio sudo[3427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop roonbridge.service Oct 27 12:31:22 km-volumio sudo[3427]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:22 km-volumio systemd[1]: Stopping RoonBridge... Oct 27 12:31:22 km-volumio systemd[1]: roonbridge.service: Main process exited, code=killed, status=15/TERM Oct 27 12:31:22 km-volumio volumio[912]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 27 12:31:22 km-volumio systemd[1]: roonbridge.service: Succeeded. Oct 27 12:31:22 km-volumio systemd[1]: Stopped RoonBridge. Oct 27 12:31:23 km-volumio sudo[3427]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:23 km-volumio volumio[912]: info: Check plugin dependencies Oct 27 12:31:23 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Oct 27 12:31:23 km-volumio volumio[912]: info: Rename folder Oct 27 12:31:23 km-volumio volumio[912]: info: Folder /tmp/downloaded_plugin.zip removed Oct 27 12:31:23 km-volumio volumio[912]: info: Move to category Oct 27 12:31:23 km-volumio volumio[912]: info: Checking if install.sh is present Oct 27 12:31:23 km-volumio volumio[912]: info: Executing install.sh Oct 27 12:31:23 km-volumio sudo[3442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/music_service/RoonBridge/install.sh Oct 27 12:31:23 km-volumio sudo[3442]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 27 12:31:23 km-volumio volumio[912]: info: Installing Roon Bridge Dependencies Oct 27 12:31:33 km-volumio volumio[912]: info: Downloading RoonBridge_linuxx64.tar.bz2 to /tmp/tmp.CuFLOFqSCw/RoonBridge_linuxx64.tar.bz2 Oct 27 12:31:33 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 12:31:33 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 12:31:33 km-volumio volumio[912]: info: Discovery: Getting this device information Oct 27 12:31:33 km-volumio volumio[912]: info: CoreCommandRouter::volumioGetState Oct 27 12:31:33 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 12:31:35 km-volumio volumio[912]: info: Unpacking RoonBridge_linuxx64.tar.bz2... Oct 27 12:31:42 km-volumio volumio[912]: info: Moving Files into plugin directory. Oct 27 12:31:42 km-volumio volumio[912]: info: Creating service file. Oct 27 12:31:42 km-volumio sudo[3442]: pam_unix(sudo:session): session closed for user root Oct 27 12:31:42 km-volumio volumio[912]: info: Exit Status: 0 Oct 27 12:31:42 km-volumio volumio[912]: Plugin install end detected on script Oct 27 12:31:42 km-volumio volumio[912]: info: Install script completed Oct 27 12:31:42 km-volumio volumio[912]: info: Done installing plugin. Oct 27 12:31:42 km-volumio volumio[912]: info: Enabling plugin RoonBridge Oct 27 12:31:42 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Oct 27 12:31:42 km-volumio volumio[912]: info: [{"prettyName":"80s80s Radio","name":"80s80s","category":"music_service","version":"1.0.4","icon":"fa-headphones","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Roon Bridge","name":"RoonBridge","category":"music_service","version":"1.0.0","icon":"fas fa-volume-up","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Spotify","name":"spop","category":"music_service","version":"4.3.0","icon":"fa-spotify","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Cast Receiver","name":"ytcr","category":"music_service","version":"1.2.0","icon":"fa-youtube","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"YouTube Music","name":"ytmusic","category":"music_service","version":"1.3.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"ScheduledRestart","name":"scheduledrestart","category":"system_controller","version":"0.7.2","icon":"fa-clock-o","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Music Services Shield","name":"music_services_shield","category":"system_hardware","version":"1.3.1","icon":"fa-shield","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":true}] Oct 27 12:31:42 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Oct 27 12:31:42 km-volumio volumio[912]: info: Folder /tmp/plugins removed Oct 27 12:31:42 km-volumio volumio[912]: info: Folder /tmp/downloaded_plugin.zip removed Oct 27 12:31:42 km-volumio volumio[912]: info: Folder /data/temp removed Oct 27 12:31:59 km-volumio volumio[912]: info: CoreCommandRouter::volumioGetState Oct 27 12:32:01 km-volumio volumio[912]: info: Executing endpoint metavolumio Oct 27 12:32:01 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Oct 27 12:32:03 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 27 12:32:03 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 27 12:32:03 km-volumio volumio[912]: info: Discovery: Getting this device information Oct 27 12:32:03 km-volumio volumio[912]: info: CoreCommandRouter::volumioGetState Oct 27 12:32:03 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 27 12:32:04 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 27 12:32:04 km-volumio volumio[912]: info: Preload queue cleared Oct 27 12:32:05 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 27 12:32:05 km-volumio volumio[912]: info: Preload queue cleared Oct 27 12:32:08 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 27 12:32:08 km-volumio volumio[912]: info: Preload queue cleared Oct 27 12:32:12 km-volumio volumio[912]: info: CoreCommandRouter::executeOnPlugin: upnp_browser , handleBrowseUri Oct 27 12:32:12 km-volumio volumio[912]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 12:32:12 km-volumio volumio[912]: TypeError: Cannot read property 'length' of undefined Oct 27 12:32:12 km-volumio volumio[912]: at /volumio/app/plugins/music_service/upnp_browser/index.js:341:25 Oct 27 12:32:12 km-volumio volumio[912]: at /volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:131:13 Oct 27 12:32:12 km-volumio volumio[912]: at Parser. (/volumio/node_modules/xml2js/lib/parser.js:304:18) Oct 27 12:32:12 km-volumio volumio[912]: at Parser.emit (events.js:400:28) Oct 27 12:32:12 km-volumio volumio[912]: at SAXParser.onclosetag (/volumio/node_modules/xml2js/lib/parser.js:262:26) Oct 27 12:32:12 km-volumio volumio[912]: at emit (/volumio/node_modules/sax/lib/sax.js:624:35) Oct 27 12:32:12 km-volumio volumio[912]: at emitNode (/volumio/node_modules/sax/lib/sax.js:629:5) Oct 27 12:32:12 km-volumio volumio[912]: at closeTag (/volumio/node_modules/sax/lib/sax.js:889:7) Oct 27 12:32:12 km-volumio volumio[912]: at SAXParser.write (/volumio/node_modules/sax/lib/sax.js:1436:13) Oct 27 12:32:12 km-volumio volumio[912]: at Parser.exports.Parser.Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:323:31) Oct 27 12:32:12 km-volumio volumio[912]: at Parser.parseString (/volumio/node_modules/xml2js/lib/parser.js:5:59) Oct 27 12:32:12 km-volumio volumio[912]: at Object.exports.parseString (/volumio/node_modules/xml2js/lib/parser.js:369:19) Oct 27 12:32:12 km-volumio volumio[912]: at IncomingMessage. (/volumio/app/plugins/music_service/upnp_browser/dlna-browser.js:92:15) Oct 27 12:32:12 km-volumio volumio[912]: at IncomingMessage.emit (events.js:412:35) Oct 27 12:32:12 km-volumio volumio[912]: at endReadableNT (internal/streams/readable.js:1333:12) Oct 27 12:32:12 km-volumio volumio[912]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Oct 27 12:32:12 km-volumio volumio[912]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 27 12:32:13 km-volumio sudo[3813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-27 12:31 Oct 27 12:32:13 km-volumio sudo[3813]: 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"