-- Logs begin at Thu 2019-02-14 19:11:59 KST, end at Tue 2025-05-27 12:37:02 KST. -- May 27 12:36:00 volumio volumio[1157]: info: Check plugin dependencies May 27 12:36:00 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 12:36:00 volumio volumio[1157]: info: Checking if plugin already exists May 27 12:36:00 volumio volumio[1157]: info: Rename folder May 27 12:36:00 volumio volumio[1157]: info: Folder /tmp/downloaded_plugin.zip removed May 27 12:36:00 volumio volumio[1157]: info: Move to category May 27 12:36:01 volumio volumio[1157]: info: Checking if install.sh is present May 27 12:36:01 volumio volumio[1157]: info: Executing install.sh May 27 12:36:01 volumio sudo[11911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/ferrum_streaming_control_technology/install.sh May 27 12:36:01 volumio sudo[11911]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:01 volumio sudo[11911]: pam_unix(sudo:session): session closed for user root May 27 12:36:01 volumio volumio[1157]: info: Install script completed May 27 12:36:01 volumio volumio[1157]: info: Adding reference to registry May 27 12:36:01 volumio volumio[1157]: info: Done installing plugin. May 27 12:36:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 12:36:01 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 27 12:36:01 volumio volumio[1157]: info: Installing ferrum streaming control technology Dependencies May 27 12:36:01 volumio volumio[1157]: Plugin install end detected on script May 27 12:36:01 volumio volumio[1157]: info: Folder /tmp/plugins removed May 27 12:36:01 volumio volumio[1157]: info: Folder /tmp/downloaded_plugin.zip removed May 27 12:36:01 volumio volumio[1157]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 12:36:01 volumio volumio[1157]: info: Folder /data/temp removed May 27 12:36:01 volumio volumio[1157]: info: FusionDsp - Rock-FusionDsp May 27 12:36:02 volumio volumio[1157]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 27 12:36:02 volumio volumio[1157]: info: Enabling plugin ferrum_streaming_control_technology May 27 12:36:02 volumio volumio[1157]: info: Loading plugin "ferrum_streaming_control_technology"... May 27 12:36:03 volumio volumio[1157]: info: PLUGIN START: ferrum_streaming_control_technology May 27 12:36:03 volumio fsct-plugin[1157]: Failed to initialize device 1d6b:0002: BOS descriptor not available, unsupported usb version 2.00 May 27 12:36:03 volumio volumio[1157]: info: CoreCommandRouter::volumioGetState May 27 12:36:03 volumio volumio[1157]: info: CorePlayQueue::getTrack 4 May 27 12:36:03 volumio fsct-plugin[1157]: Failed to initialize device 0424:2514: BOS descriptor not available, unsupported usb version 2.00 May 27 12:36:03 volumio volumio[1157]: info: FSCT Started May 27 12:36:03 volumio fsct-plugin[1157]: Failed to initialize device 0424:2514: BOS descriptor not available, unsupported usb version 2.00 May 27 12:36:03 volumio volumio[1157]: info: Done. May 27 12:36:03 volumio fsct-plugin[1157]: Failed to initialize device 0424:7800: IO error -> Permission denied (os error 13) May 27 12:36:03 volumio volumio[1157]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 12:36:03 volumio volumio[1157]: info: FusionDsp - Rock-FusionDsp May 27 12:36:04 volumio volumio[1157]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 27 12:36:04 volumio volumio[1157]: info: Enabling plugin ferrum_streaming_control_technology May 27 12:36:04 volumio volumio[1157]: info: Loading plugin "ferrum_streaming_control_technology"... May 27 12:36:04 volumio volumio[1157]: info: Applying required configuration parameters for plugin ferrum_streaming_control_technology May 27 12:36:04 volumio volumio[1157]: error: attempted to set a logger after the logging system was already initialized {"code":"GenericFailure"} May 27 12:36:04 volumio volumio[1157]: info: PLUGIN START: ferrum_streaming_control_technology May 27 12:36:04 volumio volumio[1157]: error: FSCT service already run {"code":"GenericFailure"} May 27 12:36:04 volumio volumio[1157]: info: Error: Error: FSCT service already run May 27 12:36:07 volumio volumio[1157]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/Systeminfo/volumio/buster/armhf May 27 12:36:10 volumio volumio[1157]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatest/Systeminfo/volumio/buster/armhf May 27 12:36:10 volumio volumio[1157]: info: Check plugin dependencies May 27 12:36:10 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 27 12:36:10 volumio volumio[1157]: info: Rename folder May 27 12:36:10 volumio volumio[1157]: info: Folder /tmp/downloaded_plugin.zip removed May 27 12:36:10 volumio volumio[1157]: info: Move to category May 27 12:36:11 volumio volumio[1157]: info: Checking if install.sh is present May 27 12:36:11 volumio volumio[1157]: info: Executing install.sh May 27 12:36:11 volumio sudo[11946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/Systeminfo/install.sh May 27 12:36:11 volumio sudo[11946]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:11 volumio volumio[1157]: info: Installing systeminfo May 27 12:36:11 volumio volumio[1157]: info: Configuration File exists removing it May 27 12:36:11 volumio sudo[11948]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm /data/configuration/user_interface/Systeminfo/config.json May 27 12:36:11 volumio sudo[11948]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:11 volumio sudo[11948]: pam_unix(sudo:session): session closed for user root May 27 12:36:11 volumio volumio[1157]: info: Detected cpu architecture as armv7l May 27 12:36:11 volumio sudo[11953]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/cp /data/plugins/user_interface/Systeminfo/c/hw_params_arm /data/plugins/user_interface/Systeminfo/hw_params May 27 12:36:11 volumio sudo[11953]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:11 volumio sudo[11953]: pam_unix(sudo:session): session closed for user root May 27 12:36:11 volumio sudo[11955]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/user_interface/Systeminfo/hw_params May 27 12:36:11 volumio sudo[11955]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:11 volumio sudo[11955]: pam_unix(sudo:session): session closed for user root May 27 12:36:11 volumio sudo[11957]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/user_interface/Systeminfo/firmware.sh May 27 12:36:11 volumio sudo[11957]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:11 volumio sudo[11957]: pam_unix(sudo:session): session closed for user root May 27 12:36:11 volumio volumio[1157]: Plugin install end detected on script May 27 12:36:11 volumio sudo[11946]: pam_unix(sudo:session): session closed for user root May 27 12:36:11 volumio volumio[1157]: info: Install script completed May 27 12:36:11 volumio volumio[1157]: info: Done installing plugin. May 27 12:36:11 volumio volumio[1157]: info: Enabling plugin Systeminfo May 27 12:36:11 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 12:36:11 volumio volumio[1157]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.58","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.4.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":false,"active":false},{"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":false,"active":false},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Ferrum Streaming Control Technology","name":"ferrum_streaming_control_technology","category":"user_interface","version":"1.0.1","icon":"fa-play","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Peppy-spectrum","name":"peppyspectrum","category":"user_interface","version":"0.0.35","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":true,"active":true}] May 27 12:36:11 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 27 12:36:11 volumio volumio[1157]: info: Folder /tmp/plugins removed May 27 12:36:11 volumio volumio[1157]: info: Folder /tmp/downloaded_plugin.zip removed May 27 12:36:11 volumio volumio[1157]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 12:36:11 volumio volumio[1157]: info: Folder /data/temp removed May 27 12:36:11 volumio volumio[1157]: info: FusionDsp - Rock-FusionDsp May 27 12:36:12 volumio volumio[1157]: info: FusionDsp - .Bass-FusionDsp.json,.Classic-FusionDsp.json,.Rock-FusionDsp.json,.Soundtrack-FusionDsp.json,.Voice-FusionDsp.json May 27 12:36:19 volumio volumio[1157]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 12:36:22 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 12:36:22 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 27 12:36:25 volumio volumio[1157]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 12:36:28 volumio volumio[1157]: info: CoreCommandRouter::volumioGetState May 27 12:36:28 volumio volumio[1157]: info: CorePlayQueue::getTrack 4 May 27 12:36:30 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 12:36:30 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 27 12:36:37 volumio volumio[1157]: info: Starting Uninstall of plugin user_interface - ferrum_streaming_control_technology May 27 12:36:37 volumio volumio[1157]: info: Uninstalling plugin ferrum_streaming_control_technology May 27 12:36:37 volumio volumio[1157]: info: FSCT Stopped May 27 12:36:37 volumio volumio[1157]: info: Disabling plugin ferrum_streaming_control_technology May 27 12:36:37 volumio volumio[1157]: info: Checking if uninstall.sh is present May 27 12:36:37 volumio volumio[1157]: info: Executing uninstall.sh May 27 12:36:37 volumio sudo[12048]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/user_interface/ferrum_streaming_control_technology/uninstall.sh May 27 12:36:37 volumio sudo[12048]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:37 volumio sudo[12048]: pam_unix(sudo:session): session closed for user root May 27 12:36:37 volumio volumio[1157]: info: Uninstall script completed May 27 12:36:37 volumio volumio[1157]: info: Removing plugin ferrum_streaming_control_technology from configuration May 27 12:36:38 volumio volumio[1157]: info: Successfully removed ferrum_streaming_control_technology configuration files May 27 12:36:38 volumio volumio[1157]: info: Plugin folders cleanup May 27 12:36:38 volumio volumio[1157]: info: Scanning into folder /volumio/app/plugins/ May 27 12:36:38 volumio volumio[1157]: info: Scanning category audio_interface May 27 12:36:38 volumio volumio[1157]: info: Scanning category miscellanea May 27 12:36:38 volumio volumio[1157]: info: Scanning category music_service May 27 12:36:38 volumio volumio[1157]: info: Scanning category plugins.json May 27 12:36:38 volumio volumio[1157]: info: Scanning category system_controller May 27 12:36:38 volumio volumio[1157]: info: Scanning category user_interface May 27 12:36:38 volumio volumio[1157]: info: Scanning into folder /data/plugins/ May 27 12:36:38 volumio volumio[1157]: info: Scanning category audio_interface May 27 12:36:38 volumio volumio[1157]: info: Scanning category music_service May 27 12:36:38 volumio volumio[1157]: info: Scanning category system_controller May 27 12:36:38 volumio volumio[1157]: info: Scanning category user_interface May 27 12:36:38 volumio volumio[1157]: info: Cleaning folder for ferrum_streaming_control_technology May 27 12:36:38 volumio volumio[1157]: info: Plugin folders cleanup completed May 27 12:36:38 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 12:36:38 volumio volumio[1157]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.58","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":true},{"prettyName":"YouTube2","name":"youtube2","category":"music_service","version":"1.4.1","icon":"fa-youtube-play","isManuallyInstalled":false,"enabled":false,"active":false},{"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":false,"active":false},{"prettyName":"Amplifier Switch","name":"ampswitch","category":"system_controller","version":"0.2.1","icon":"fa-power-off","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"AutoStart","name":"autostart","category":"system_controller","version":"3.0.4","icon":"fa-lightbulb-o","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"System information","name":"Systeminfo","category":"user_interface","version":"3.0.6","icon":"fa-info-circle","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.7.5","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":true,"active":true},{"prettyName":"Peppy-spectrum","name":"peppyspectrum","category":"user_interface","version":"0.0.35","icon":"fa-bar-chart","isManuallyInstalled":false,"enabled":true,"active":true}] May 27 12:36:38 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 27 12:36:43 volumio volumio[1157]: info: CoreCommandRouter::getUIConfigOnPlugin May 27 12:36:47 volumio volumio[1157]: info: CALLMETHOD: user_interface Systeminfo getsysteminfo undefined May 27 12:36:47 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: Systeminfo , getsysteminfo May 27 12:36:47 volumio sudo[12070]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/vcgencmd version May 27 12:36:47 volumio sudo[12070]: pam_unix(sudo:session): session opened for user root by (uid=0) May 27 12:36:47 volumio sudo[12070]: pam_unix(sudo:session): session closed for user root May 27 12:36:53 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus May 27 12:36:53 volumio volumio[1157]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken May 27 12:36:54 volumio volumio[1157]: info: board is Raspberry Pi 3 Model B Plus Rev 1.3 May 27 12:36:54 volumio volumio[1157]: Storage info 26908M 10528M 14988M May 27 12:36:54 volumio volumio[1157]: Storage info 26908M 10528M 14988M May 27 12:36:54 volumio volumio[1157]: BBBBBBBBBBBBBB-CPU Temp 49 °C May 27 12:36:54 volumio volumio[1157]: info: Firmware detected: Nov 11 2024 15:50:32 version 903570ba72a9e117f92e5499de439f59dd96e417 (clean) (release) (start) May 27 12:36:54 volumio volumio[1157]: info: failed Error: Command failed: /data/plugins/user_interface/Systeminfo/hw_params hw:2 >/data/configuration/user_interface/Systeminfo/config.json May 27 12:36:54 volumio volumio[1157]: cannot open device 'hw:2': Device or resource busy May 27 12:37:00 volumio volumio[1157]: info: Starting Uninstall of plugin system_controller - ampswitch May 27 12:37:00 volumio volumio[1157]: info: Uninstalling plugin ampswitch May 27 12:37:00 volumio volumio[1157]: info: [ASDebug] Port: 24 May 27 12:37:00 volumio volumio[1157]: info: [ASDebug] Inverted: false May 27 12:37:00 volumio volumio[1157]: info: [ASDebug] Delay: 720 May 27 12:37:00 volumio volumio[1157]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 12:37:00 volumio volumio[1157]: Error: EBADF: bad file descriptor, close May 27 12:37:00 volumio volumio[1157]: at Object.closeSync (fs.js:439:3) May 27 12:37:00 volumio volumio[1157]: at Object.closeSync (/volumio/node_modules/graceful-fs/graceful-fs.js:74:20) May 27 12:37:00 volumio volumio[1157]: at Object.closeSync (/data/plugins/system_controller/ampswitch/node_modules/graceful-fs/graceful-fs.js:51:27) May 27 12:37:00 volumio volumio[1157]: at Gpio.unexport (/data/plugins/system_controller/ampswitch/node_modules/onoff/onoff.js:307:8) May 27 12:37:00 volumio volumio[1157]: at AmpSwitchController.freeGPIO (/data/plugins/system_controller/ampswitch/index.js:242:19) May 27 12:37:00 volumio volumio[1157]: at AmpSwitchController.onStop (/data/plugins/system_controller/ampswitch/index.js:90:10) May 27 12:37:00 volumio volumio[1157]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) May 27 12:37:00 volumio volumio[1157]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10) May 27 12:37:00 volumio volumio[1157]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22) May 27 12:37:00 volumio volumio[1157]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1260:45) May 27 12:37:00 volumio volumio[1157]: at Socket.emit (events.js:315:20) May 27 12:37:00 volumio volumio[1157]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 May 27 12:37:00 volumio volumio[1157]: at processTicksAndRejections (internal/process/task_queues.js:75:11) { May 27 12:37:00 volumio volumio[1157]: errno: -9, May 27 12:37:00 volumio volumio[1157]: syscall: 'close', May 27 12:37:00 volumio volumio[1157]: code: 'EBADF' May 27 12:37:00 volumio volumio[1157]: } May 27 12:37:00 volumio volumio[1157]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 27 12:37:02 volumio sudo[12443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-27 12:36 May 27 12:37:02 volumio sudo[12443]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"