-- Logs begin at Sun 2025-06-22 20:46:24 CEST, end at Sun 2025-06-22 20:55:10 CEST. -- Jun 22 20:54:00 volumio volumio[1228]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Jun 22 20:54:00 volumio volumio[1228]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-ef5qa6eg/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Jun 22 20:54:00 volumio volumio[1228]: info: Successfully built camilladsp-plot Jun 22 20:54:00 volumio volumio[1228]: info: copying hw detection script Jun 22 20:54:00 volumio volumio[1228]: info: Detected cpu architecture as armv7l Jun 22 20:54:02 volumio volumio[1228]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 22 20:54:02 volumio volumio[1228]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 22 20:54:02 volumio volumio[1228]: info: Discovery: Getting this device information Jun 22 20:54:02 volumio volumio[1228]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:02 volumio volumio[1228]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:02 volumio volumio[1228]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:54:04 volumio sudo[3775]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/cp /data/plugins/audio_interface/fusiondsp/c/hw_params_arm /data/plugins/audio_interface/fusiondsp/hw_params Jun 22 20:54:04 volumio sudo[3775]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:04 volumio sudo[3775]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:04 volumio sudo[3784]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/bin/chmod +x /data/plugins/audio_interface/fusiondsp/hw_params Jun 22 20:54:04 volumio sudo[3784]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:04 volumio sudo[3784]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:04 volumio sudo[3793]: root : TTY=unknown ; PWD=/tmp ; USER=root ; COMMAND=/usr/bin/apt-get -y install drc Jun 22 20:54:04 volumio sudo[3793]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:04 volumio volumio[1228]: info: Reading package lists... Jun 22 20:54:04 volumio volumio[1228]: info: Building dependency tree... Jun 22 20:54:04 volumio volumio[1228]: info: Reading state information... Jun 22 20:54:05 volumio volumio[1228]: info: drc is already the newest version (3.2.2~dfsg0-2). Jun 22 20:54:05 volumio sudo[3793]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:05 volumio volumio[1228]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Jun 22 20:54:05 volumio sudo[3357]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:05 volumio volumio[1228]: Plugin install end detected on script Jun 22 20:54:05 volumio volumio[1228]: info: Install script completed Jun 22 20:54:05 volumio volumio[1228]: info: Done installing plugin. Jun 22 20:54:05 volumio volumio[1228]: info: Enabling plugin fusiondsp Jun 22 20:54:05 volumio volumio[1228]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Jun 22 20:54:05 volumio volumio[1228]: info: [{"prettyName":"FusionDsp","name":"fusiondsp","category":"audio_interface","version":"1.0.61","icon":"fa-sliders fa-rotate-90","isManuallyInstalled":true,"enabled":true,"active":false},{"prettyName":"Mpd http & Icecast output","name":"mpdoutput","category":"audio_interface","version":"1.0.5","icon":"fa-music","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"miniDLNA","name":"minidlna","category":"music_service","version":"3.1.12","icon":"fa-share-alt","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"Backup & Restore Data","name":"backup_restore","category":"system_controller","version":"0.7.4","icon":"fa-floppy-o","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"GPIO Buttons","name":"gpio-buttons","category":"system_hardware","version":"0.8.3","icon":"fa-microchip","isManuallyInstalled":false,"enabled":false,"active":false},{"prettyName":"GPIO Control","name":"gpio_control","category":"system_hardware","version":"1.0.1","icon":"fa-microchip","isManuallyInstalled":false,"enabled":true,"active":false},{"prettyName":"Now Playing","name":"now_playing","category":"user_interface","version":"0.3.8","icon":"fa-play-circle","isManuallyInstalled":false,"enabled":false,"active":false}] Jun 22 20:54:05 volumio volumio[1228]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Jun 22 20:54:05 volumio volumio[1228]: info: Folder /tmp/plugins removed Jun 22 20:54:05 volumio volumio[1228]: info: Folder /tmp/downloaded_plugin.zip removed Jun 22 20:54:05 volumio volumio[1228]: info: Folder /data/temp removed Jun 22 20:54:05 volumio volumio[1228]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 20:54:05 volumio volumio[1228]: info: FusionDsp - Jun 22 20:54:05 volumio volumio[1228]: info: FusionDsp - Jun 22 20:54:16 volumio volumio[1228]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jun 22 20:54:22 volumio volumio[1228]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jun 22 20:54:22 volumio volumio[1228]: info: FusionDsp - Stopping FusionDsp service Jun 22 20:54:22 volumio volumio[1228]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 20:54:22 volumio volumio[1228]: TypeError: Cannot read property 'stop' of null Jun 22 20:54:22 volumio volumio[1228]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Jun 22 20:54:22 volumio volumio[1228]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 22 20:54:22 volumio volumio[1228]: at /volumio/app/pluginmanager.js:956:12 Jun 22 20:54:22 volumio volumio[1228]: at ChildProcess.exithandler (child_process.js:374:7) Jun 22 20:54:22 volumio volumio[1228]: at ChildProcess.emit (events.js:400:28) Jun 22 20:54:22 volumio volumio[1228]: at maybeClose (internal/child_process.js:1088:16) Jun 22 20:54:22 volumio volumio[1228]: at Process.ChildProcess._handle.onexit (internal/child_process.js:296:5) Jun 22 20:54:22 volumio volumio[1228]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 20:54:23 volumio sudo[3849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-22 20:53 Jun 22 20:54:23 volumio sudo[3849]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:23 volumio sudo[3849]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:23 volumio volumio-remote-updater[539]: [2025-06-22 20:54:23] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 22 20:54:23 volumio vtcs[2445]: [2025-06-22 20:54:23.327] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jun 22 20:54:23 volumio volumio-remote-updater[539]: [2025-06-22 20:54:23] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 22 20:54:23 volumio qobuz-connect[2344]: 20250622 20:54:23.331 [2344.2344] INFO SampleApp: Socket closed Jun 22 20:54:23 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 22 20:54:23 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 22 20:54:23 volumio systemd[1]: Started dynamicswap service. Jun 22 20:54:23 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 22 20:54:23 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 22 20:54:23 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 1. Jun 22 20:54:23 volumio systemd[1]: Started dynamicswap service. Jun 22 20:54:23 volumio systemd[1]: Stopped Volumio Backend Module. Jun 22 20:54:23 volumio systemd[1]: Started Volumio Backend Module. Jun 22 20:54:23 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 22 20:54:24 volumio volumio[3870]: info: ------------------------------------------- Jun 22 20:54:24 volumio volumio[3870]: info: ----- Volumio3 ---- Jun 22 20:54:24 volumio volumio[3870]: info: ------------------------------------------- Jun 22 20:54:24 volumio volumio[3870]: info: ----- System startup ---- Jun 22 20:54:24 volumio volumio[3870]: info: ------------------------------------------- Jun 22 20:54:25 volumio volumio[3870]: info: MYVOLUMIO Environment detected Jun 22 20:54:25 volumio volumio[3870]: info: Configured plugin user_interface/touch_display cannot be loaded. Removing from configuration Jun 22 20:54:25 volumio volumio[3870]: info: Plugin folders cleanup Jun 22 20:54:25 volumio volumio[3870]: info: Scanning into folder /volumio/app/plugins/ Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category audio_interface Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category miscellanea Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category music_service Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category plugins.json Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category system_controller Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category user_interface Jun 22 20:54:25 volumio volumio[3870]: info: Scanning into folder /data/plugins/ Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category audio_interface Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category music_service Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category system_controller Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category system_hardware Jun 22 20:54:25 volumio volumio[3870]: info: Scanning category user_interface Jun 22 20:54:25 volumio volumio[3870]: info: Plugin folders cleanup completed Jun 22 20:54:25 volumio volumio[3870]: info: ------------------------------------------- Jun 22 20:54:25 volumio volumio[3870]: info: ----- Core plugins startup ---- Jun 22 20:54:25 volumio volumio[3870]: info: ------------------------------------------- Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugins from folder /volumio/app/plugins/ Jun 22 20:54:25 volumio volumio[3870]: info: Adding plugin upnp to MyMusic Plugins Jun 22 20:54:25 volumio volumio[3870]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 22 20:54:25 volumio volumio[3870]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugins from folder /data/plugins/ Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "system"... Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "appearance"... Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "network"... Jun 22 20:54:25 volumio volumio[3870]: info: Refreshing Cached IP Addresses Jun 22 20:54:25 volumio sudo[3897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 22 20:54:25 volumio sudo[3899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 22 20:54:25 volumio sudo[3897]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "services"... Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "alsa_controller"... Jun 22 20:54:25 volumio sudo[3897]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:25 volumio sudo[3899]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:25 volumio sudo[3899]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:25 volumio sudo[3926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 22 20:54:25 volumio sudo[3926]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:25 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "wizard"... Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "networkfs"... Jun 22 20:54:25 volumio volumio[3870]: info: Starting Udev Watcher for removable devices Jun 22 20:54:25 volumio volumio[3870]: info: Ignoring mount for partition: boot Jun 22 20:54:25 volumio volumio[3870]: info: Ignoring mount for partition: volumio Jun 22 20:54:25 volumio volumio[3870]: info: Ignoring mount for partition: volumio_data Jun 22 20:54:25 volumio volumio[3870]: info: Ignoring mount for partition: boot Jun 22 20:54:25 volumio volumio[3870]: info: Ignoring mount for partition: volumio Jun 22 20:54:25 volumio volumio[3870]: info: Ignoring mount for partition: volumio_data Jun 22 20:54:25 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "volumio_command_line_client"... Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "upnp"... Jun 22 20:54:25 volumio volumio[3870]: info: [1750618465765] Starting Upmpd Daemon Jun 22 20:54:25 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "my_music"... Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "mpd"... Jun 22 20:54:25 volumio volumio[3870]: info: Loading plugin "upnp_browser"... Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "alarm-clock"... Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "airplay_emulation"... Jun 22 20:54:26 volumio volumio[3870]: info: Starting Shairport Sync Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "last_100"... Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "webradio"... Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "i2s_dacs"... Jun 22 20:54:26 volumio volumio[3870]: info: I2S DAC not set, start Auto-detection Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "volumiodiscovery"... Jun 22 20:54:26 volumio volumio[3870]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 20:54:26 volumio volumio[3870]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:54:26 volumio volumio[3870]: *** WARNING *** For more information see Jun 22 20:54:26 volumio volumio[3870]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 20:54:26 volumio volumio[3870]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:54:26 volumio volumio[3870]: *** WARNING *** For more information see Jun 22 20:54:26 volumio node[3870]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 20:54:26 volumio node[3870]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:54:26 volumio node[3870]: *** WARNING *** For more information see Jun 22 20:54:26 volumio node[3870]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 20:54:26 volumio node[3870]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:54:26 volumio node[3870]: *** WARNING *** For more information see Jun 22 20:54:26 volumio volumio[3870]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 22 20:54:26 volumio volumio[3870]: info: Discovery: Started advertising with name: Volumio Jun 22 20:54:26 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 20:54:26 volumio volumio[3870]: info: Plugin gpio-buttons is not enabled Jun 22 20:54:26 volumio volumio[3870]: info: Plugin now_playing is not enabled Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "outputs"... Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "albumart"... Jun 22 20:54:26 volumio volumio[3870]: info: Plugin example_plugin is not enabled Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "inputs"... Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "updater_comm"... Jun 22 20:54:26 volumio volumio[3870]: info: Plugin mpdemulation is not enabled Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "rest_api"... Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "websocket"... Jun 22 20:54:26 volumio volumio[3870]: info: Starting Socket.io Server version 2.3.0 Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "fusiondsp"... Jun 22 20:54:26 volumio volumio[3870]: Forking 3 albumart workers Jun 22 20:54:26 volumio volumio[3870]: info: Applying required configuration parameters for plugin fusiondsp Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "mpdoutput"... Jun 22 20:54:26 volumio volumio[3870]: info: Plugin minidlna is not enabled Jun 22 20:54:26 volumio volumio[3870]: info: Plugin backup_restore is not enabled Jun 22 20:54:26 volumio volumio[3870]: info: Loading plugin "gpio_control"... Jun 22 20:54:27 volumio sudo[3926]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:27 volumio volumio[3870]: Starting albumart workers Jun 22 20:54:27 volumio volumio[3870]: Starting albumart workers Jun 22 20:54:27 volumio volumio[3870]: Starting albumart workers Jun 22 20:54:27 volumio volumio[3870]: error: !!!! WARNING !!!! Jun 22 20:54:27 volumio volumio[3870]: error: The plugin system_hardware/gpio_control failed to load, setting it to stopped. Error: TypeError: Cannot read property '0' of null Jun 22 20:54:27 volumio volumio[3870]: error: Stack trace: TypeError: Cannot read property '0' of null Jun 22 20:54:27 volumio volumio[3870]: at GPIOControl.getPiBoardInfo (/data/plugins/system_hardware/gpio_control/index.js:511:12) Jun 22 20:54:27 volumio volumio[3870]: at new GPIOControl (/data/plugins/system_hardware/gpio_control/index.js:35:22) Jun 22 20:54:27 volumio volumio[3870]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:24) Jun 22 20:54:27 volumio volumio[3870]: at /volumio/app/pluginmanager.js:338:34 Jun 22 20:54:27 volumio volumio[3870]: at Array.forEach () Jun 22 20:54:27 volumio volumio[3870]: at HashMap. (/volumio/app/pluginmanager.js:337:20) Jun 22 20:54:27 volumio volumio[3870]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jun 22 20:54:27 volumio volumio[3870]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jun 22 20:54:27 volumio volumio[3870]: at PluginManager.loadCorePlugins (/volumio/app/pluginmanager.js:335:18) Jun 22 20:54:27 volumio volumio[3870]: at PluginManager.startPlugins (/volumio/app/pluginmanager.js:102:26) Jun 22 20:54:27 volumio volumio[3870]: at new CoreCommandRouter (/volumio/app/index.js:48:42) Jun 22 20:54:27 volumio volumio[3870]: at Object. (/volumio/index.js:54:21) Jun 22 20:54:27 volumio volumio[3870]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Jun 22 20:54:27 volumio volumio[3870]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Jun 22 20:54:27 volumio volumio[3870]: at Module.load (internal/modules/cjs/loader.js:979:32) Jun 22 20:54:27 volumio volumio[3870]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Jun 22 20:54:27 volumio volumio[3870]: error: !!!! WARNING !!!! Jun 22 20:54:27 volumio volumio[3870]: info: Loading i18n strings for locale pl Jun 22 20:54:27 volumio volumio[3870]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jun 22 20:54:27 volumio volumio[3870]: Updating browse sources language Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::initPlayerControls Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: Express server listening on port 3000 Jun 22 20:54:27 volumio volumio[3870]: [Metrics] WebUI: 3s 165.79ms Jun 22 20:54:27 volumio volumio[3870]: info: CoreStateMachine::resetVolumioState Jun 22 20:54:27 volumio volumio[3870]: info: CoreStateMachine::getcurrentVolume Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioRetrievevolume Jun 22 20:54:27 volumio volumio[3870]: info: CoreStateMachine::pushState Jun 22 20:54:27 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioPushState Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 22 20:54:27 volumio volumio[3870]: info: Completed loading Core Plugins Jun 22 20:54:27 volumio volumio[3870]: info: Preparing to generate the ALSA configuration file Jun 22 20:54:27 volumio volumio[3870]: info: Volumio Network Manager: Network status updated: 1 Jun 22 20:54:27 volumio volumio[3870]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 22 20:54:27 volumio volumio[3870]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 22 20:54:27 volumio volumio[3870]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 22 20:54:27 volumio volumio[3870]: info: Reading ALSA contributions from plugins. Jun 22 20:54:27 volumio volumio[3870]: verbose: New Socket.io Connection to 192.168.2.13 from 192.168.2.3 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.91 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 22 20:54:27 volumio volumio[3870]: verbose: New Socket.io Connection to 192.168.2.13:3000 from 192.168.2.3 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 22 20:54:27 volumio volumio[3870]: info: Discovery: Getting this device information Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:27 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:54:27 volumio volumio[3870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 22 20:54:27 volumio volumio[3870]: info: Reloading queue from file Jun 22 20:54:27 volumio volumio[3870]: info: CoreStateMachine::setRepeat null single undefined Jun 22 20:54:27 volumio volumio[3870]: info: CoreStateMachine::pushState Jun 22 20:54:27 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioPushState Jun 22 20:54:27 volumio volumio[3870]: info: CoreStateMachine::setRandom null Jun 22 20:54:27 volumio volumio[3870]: info: CoreStateMachine::pushState Jun 22 20:54:27 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioPushState Jun 22 20:54:27 volumio volumio[3870]: info: Setting Device type: Tinkerboard Jun 22 20:54:27 volumio volumio[3870]: verbose: New Socket.io Connection to 192.168.2.13:3000 from 192.168.2.3 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:27 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 22 20:54:27 volumio volumio[3870]: info: Discovery: adding e32e0ba1-1a29-4a33-86a1-56d38ac2a3c2 Jun 22 20:54:27 volumio volumio[3870]: info: Discovery: Found device Volumio Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:27 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:27 volumio volumio[3870]: info: Asound.conf file unchanged, so no further update is needed Jun 22 20:54:27 volumio volumio[3870]: info: Output device has changed, restarting MPD Jun 22 20:54:27 volumio volumio[3870]: info: Output device has changed, restarting Shairport Sync Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:27 volumio sudo[4054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 20:54:27 volumio sudo[4056]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:54:27 volumio sudo[4054]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:27 volumio sudo[4054]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:27 volumio sudo[4056]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:27 volumio volumio[3870]: info: ___________ START PLUGINS ___________ Jun 22 20:54:27 volumio volumio[3870]: info: ControllerMpd::onStart: Initializing MPD Jun 22 20:54:27 volumio volumio[3870]: info: Creating MPD Configuration file Jun 22 20:54:27 volumio systemd[1]: Stopping Music Player Daemon... Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 20:54:27 volumio volumio[3870]: info: [1750618467934] CoreMusicLibrary::Adding element Serwery Mediów Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:54:27 volumio sudo[4075]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 20:54:27 volumio sudo[4077]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:27 volumio sudo[4075]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:27 volumio sudo[4077]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:27 volumio sudo[4075]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:27 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:54:27 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:54:27 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:27 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 20:54:28 volumio volumio[3870]: info: [1750618468019] CoreMusicLibrary::Adding element Last_100 Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 20:54:28 volumio volumio[3870]: info: [1750618468021] CoreMusicLibrary::Adding element Webradio Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:54:28 volumio volumio[3870]: info: Initializing BBC Radios Jun 22 20:54:28 volumio sudo[4094]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:28 volumio sudo[4094]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio volumio[3870]: info: Loading i18n strings for locale pl Jun 22 20:54:28 volumio volumio[3870]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: FusionDsp - mixtype--------------------- None Jun 22 20:54:28 volumio sudo[4094]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:28 volumio volumio[3870]: info: Volumio Calling Home Jun 22 20:54:28 volumio volumio[3870]: info: Preparing to generate the ALSA configuration file Jun 22 20:54:28 volumio volumio[3870]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 22 20:54:28 volumio volumio[3870]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 22 20:54:28 volumio volumio[3870]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 22 20:54:28 volumio volumio[3870]: info: Reading ALSA contributions from plugins. Jun 22 20:54:28 volumio volumio[3870]: info: Volumio called home Jun 22 20:54:28 volumio volumio[3870]: info: MPD Permissions set Jun 22 20:54:28 volumio volumio[3870]: info: MPD Permissions set Jun 22 20:54:28 volumio volumio[3870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio-remote-updater[539]: [2025-06-22 20:54:28] [connect] Successful connection Jun 22 20:54:28 volumio volumio[3870]: verbose: New Socket.io Connection to 192.168.2.13 from 192.168.2.3 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.91 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jun 22 20:54:28 volumio volumio-remote-updater[539]: [2025-06-22 20:54:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750618468 101 Jun 22 20:54:28 volumio volumio[3870]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 7 Jun 22 20:54:28 volumio volumio[3870]: info: Starting Shairport Sync Jun 22 20:54:28 volumio volumio[3870]: info: Starting Shairport Sync Jun 22 20:54:28 volumio volumio[3870]: info: Starting Shairport Sync Jun 22 20:54:28 volumio sudo[4134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:54:28 volumio sudo[4136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:54:28 volumio sudo[4134]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:28 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:28 volumio sudo[4142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 22 20:54:28 volumio sudo[4136]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 20:54:28 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 20:54:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:28 volumio sudo[4142]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio volumio[3870]: info: Asound.conf file unchanged, so no further update is needed Jun 22 20:54:28 volumio volumio[3870]: info: Output device has changed, restarting MPD Jun 22 20:54:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:28 volumio sudo[4134]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:28 volumio volumio[3870]: info: Output device has changed, restarting Shairport Sync Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 20:54:28 volumio sudo[4158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 20:54:28 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 22 20:54:28 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 20:54:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:28 volumio sudo[4161]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:54:28 volumio sudo[4158]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:28 volumio sudo[4142]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:28 volumio sudo[4136]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:28 volumio sudo[4161]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio sudo[4158]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioGetVisibleSources Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:28 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 22 20:54:28 volumio volumio[3870]: info: Received Get System Info Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 22 20:54:28 volumio volumio[3870]: info: Discovery: Getting this device information Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:28 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:28 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:28 volumio volumio[3870]: info: Listing playlists Jun 22 20:54:28 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 22 20:54:28 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:54:28 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:54:28 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:54:28 volumio volumio[3870]: info: MPD Permissions set Jun 22 20:54:28 volumio volumio[3870]: info: Shairport-Sync Started Jun 22 20:54:28 volumio volumio[3870]: Error adding Membership: Error: addMembership EINVAL Jun 22 20:54:28 volumio volumio[3870]: info: Shairport-Sync Started Jun 22 20:54:28 volumio volumio[3870]: info: Shairport-Sync Started Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:28 volumio sudo[4188]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:54:28 volumio sudo[4188]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio sudo[4188]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 20:54:28 volumio volumio[3870]: info: Starting Shairport Sync Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:28 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:28 volumio volumio[3870]: info: CoreCommandRouter::volumioPause Jun 22 20:54:28 volumio volumio[3870]: info: CoreStateMachine::pause Jun 22 20:54:28 volumio volumio[3870]: info: mpdhttpout --- Volumio set on pause Jun 22 20:54:28 volumio volumio[3870]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Jun 22 20:54:28 volumio sudo[4206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:54:28 volumio volumio[3870]: info: FusionDsp - Jun 22 20:54:28 volumio sudo[4206]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 20:54:28 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 20:54:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:28 volumio sudo[4206]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:28 volumio volumio[3870]: info: FusionDsp - Jun 22 20:54:29 volumio volumio[3870]: info: FusionDsp - Jun 22 20:54:29 volumio volumio[3870]: info: FusionDsp - Jun 22 20:54:29 volumio volumio[3870]: info: Shairport-Sync Started Jun 22 20:54:29 volumio volumio[3870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 22 20:54:29 volumio mpd[4212]: Jun 22 20:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 22 20:54:29 volumio systemd[1]: Started Music Player Daemon. Jun 22 20:54:29 volumio sudo[4161]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:29 volumio sudo[4056]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:29 volumio sudo[4077]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:29 volumio volumio[3870]: info: Completed starting Core Plugins Jun 22 20:54:29 volumio volumio[3870]: info: ------------------------------------------- Jun 22 20:54:29 volumio volumio[3870]: info: ----- MyVolumio plugins startup ---- Jun 22 20:54:29 volumio volumio[3870]: info: ------------------------------------------- Jun 22 20:54:29 volumio volumio[3870]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 22 20:54:29 volumio volumio[3870]: error: MPD error: The expression evaluated to a falsy value: Jun 22 20:54:29 volumio volumio[3870]: assert.ok(self.idling) Jun 22 20:54:29 volumio volumio[3870]: error: The expression evaluated to a falsy value: Jun 22 20:54:29 volumio volumio[3870]: assert.ok(self.idling) Jun 22 20:54:29 volumio volumio[3870]: error: MPD error: The expression evaluated to a falsy value: Jun 22 20:54:29 volumio volumio[3870]: assert.ok(self.idling) Jun 22 20:54:29 volumio volumio[3870]: error: The expression evaluated to a falsy value: Jun 22 20:54:29 volumio volumio[3870]: assert.ok(self.idling) Jun 22 20:54:29 volumio volumio[3870]: info: MPD running with PID4212 Jun 22 20:54:29 volumio volumio[3870]: ,establishing connection Jun 22 20:54:29 volumio volumio[3870]: error: updateQueue error: null Jun 22 20:54:29 volumio volumio[3870]: error: updateQueue error: null Jun 22 20:54:30 volumio volumio[3870]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 22 20:54:30 volumio volumio[3870]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jun 22 20:54:30 volumio volumio[3870]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 22 20:54:30 volumio volumio[3870]: info: camilladsp service started and running in background, instance 1 Jun 22 20:54:30 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:30 volumio volumio[3870]: cannot open device 'volumioHw': Device or resource busy Jun 22 20:54:30 volumio volumio[3870]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 22 20:54:30 volumio volumio[3870]: cannot open device 'volumioHw': Device or resource busy Jun 22 20:54:30 volumio volumio[3870]: info: FusionDsp loaded Jun 22 20:54:30 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:54:30 volumio volumio[3870]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 22 20:54:30 volumio volumio[3870]: info: Adding Signal Path Element [object Object] Jun 22 20:54:30 volumio volumio[3870]: info: Adding fusiondspeq DSP Signal Path Element Jun 22 20:54:30 volumio volumio[3870]: info: FusionDsp - ---- installed callbackRead Jun 22 20:54:30 volumio volumio[3870]: info: FusionDsp - If filter freq >samplerate/2 then disable it Jun 22 20:54:30 volumio volumio[3870]: info: FusionDsp - Nulleq applied Jun 22 20:54:30 volumio sudo[4252]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 22 20:54:30 volumio sudo[4252]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:30 volumio volumio[3870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 9 Jun 22 20:54:30 volumio systemd[1]: Started FusionDsp Daemon. Jun 22 20:54:30 volumio sudo[4252]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:30 volumio volumio[3870]: info: FusionDsp - {"Reload":{"result":"Ok"}} Jun 22 20:54:30 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jun 22 20:54:30 volumio sudo[4264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:54:30 volumio sudo[4264]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:30 volumio systemd[1]: Stopping Music Player Daemon... Jun 22 20:54:30 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:54:30 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:54:30 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:54:31 volumio sudo[4270]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:54:31 volumio sudo[4270]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:31 volumio sudo[4270]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:31 volumio mpd[4279]: Jun 22 20:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 22 20:54:31 volumio systemd[1]: Started Music Player Daemon. Jun 22 20:54:31 volumio sudo[4264]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:31 volumio volumio[3870]: error: updateQueue error: null Jun 22 20:54:31 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 22 20:54:31 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 22 20:54:31 volumio volumio[3870]: info: Discovery: Getting this device information Jun 22 20:54:31 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:31 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:31 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:54:34 volumio volumio[3870]: error: Failed LSINFO: Error: [50@0] {lsinfo} No such directory Jun 22 20:54:35 volumio sudo[4300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 22 20:54:35 volumio sudo[4302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 22 20:54:35 volumio sudo[4300]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:35 volumio sudo[4306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 22 20:54:35 volumio sudo[4300]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:35 volumio sudo[4302]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:35 volumio sudo[4302]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:35 volumio sudo[4306]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:35 volumio systemd[1]: Started UPnP Renderer front-end to MPD. Jun 22 20:54:35 volumio sudo[4306]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:35 volumio volumio[3870]: info: Upmpdcli Daemon Started Jun 22 20:54:35 volumio volumio[4326]: Generating RSA private key, 4096 bit long modulus (2 primes) Jun 22 20:54:36 volumio volumio[3870]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin tidal to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan premium Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin multiroom to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin metavolumio to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin smart_inputs to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin hi_res_audio to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin tidal to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin qobuzconnect to plan superstar Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin bluetooth to plan virtuoso Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin manifestui to plan virtuoso Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin cd_controller to plan virtuoso Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin tidal to plan virtuoso Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin qobuz to plan virtuoso Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Adding plugin tidalconnect to plan virtuoso Jun 22 20:54:38 volumio volumio[3870]: info: Adding plugin bluetooth to MyMusic Plugins Jun 22 20:54:38 volumio volumio[3870]: info: Adding plugin multiroom to MyMusic Plugins Jun 22 20:54:38 volumio volumio[3870]: info: Adding plugin metavolumio to MyMusic Plugins Jun 22 20:54:38 volumio volumio[3870]: info: Adding plugin cd_controller to MyMusic Plugins Jun 22 20:54:38 volumio volumio[3870]: info: Adding plugin qobuzconnect to MyMusic Plugins Jun 22 20:54:38 volumio volumio[3870]: info: Adding plugin smart_inputs to MyMusic Plugins Jun 22 20:54:38 volumio volumio[3870]: info: Adding plugin tidalconnect to MyMusic Plugins Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "my_volumio"... Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] MyVolumio plugin successfully loaded Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin system_controller.my_volumio Jun 22 20:54:38 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:38 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:38 volumio volumio[3870]: info: Starting MyVolumio Remote Streaming Endpoints Jun 22 20:54:38 volumio volumio[3870]: info: MyVolumio login type: Token Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] MyVolumio plugin successfully started Jun 22 20:54:38 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "streaming_services"... Jun 22 20:54:39 volumio volumio[3870]: info: Starting Streaming Service Transparent Proxy Jun 22 20:54:39 volumio volumio[3870]: info: [MyVolumio PluginManager] Streaming Services plugin successfully loaded Jun 22 20:54:39 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.streaming_services Jun 22 20:54:39 volumio volumio[3870]: info: Streaming services startup Jun 22 20:54:39 volumio volumio[3870]: info: Starting Streaming Daemon Jun 22 20:54:39 volumio sudo[4354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 22 20:54:39 volumio volumio[3870]: info: [MyVolumio PluginManager] Streaming Services plugin successfully started Jun 22 20:54:39 volumio sudo[4354]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:39 volumio sudo[4354]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:39 volumio volumio[3870]: error: Cannot start Volumio Streaming Daemon Jun 22 20:54:39 volumio volumio[3870]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 22 20:54:39 volumio volumio[3870]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 22 20:54:39 volumio volumio[4326]: .......................................................................++++ Jun 22 20:54:39 volumio volumio[3870]: STREAMING PROXY: Starting server on port 3245 Jun 22 20:54:39 volumio volumio[3870]: Node JS runtime: 14 Jun 22 20:54:40 volumio volumio[3870]: info: MYVOLUMIO SUCCESSFULLY LOGGED IN Jun 22 20:54:40 volumio volumio[3870]: info: MyVolumio token set successfully Jun 22 20:54:40 volumio volumio[3870]: info: MYVOLUMIO: Adding device Jun 22 20:54:40 volumio volumio[3870]: info: MYVOLUMIO: Evaluating Server Jun 22 20:54:40 volumio volumio[3870]: info: Upgrading User Account from device code Jun 22 20:54:40 volumio volumio[3870]: info: MyVolumio Plan changed: premium Jun 22 20:54:40 volumio volumio[3870]: info: [MyVolumio PluginManager] Subscribed plan changed to premium Jun 22 20:54:40 volumio volumio[3870]: info: Removing browser output: myVolumio user plan is not superstar Jun 22 20:54:40 volumio volumio[3870]: info: Removing audio output: Jun 22 20:54:40 volumio volumio[3870]: info: MYVOLUMIO: Adding device Jun 22 20:54:40 volumio volumio[3870]: info: MYVOLUMIO: Evaluating Server Jun 22 20:54:40 volumio volumio[3870]: info: Remote config written successfully Jun 22 20:54:40 volumio volumio[3870]: info: Starting Tunnel 1 Jun 22 20:54:40 volumio volumio[3870]: info: Starting Tunnel Connection Checker Jun 22 20:54:40 volumio volumio[3870]: info: Completed starting MyVolumio Plugin Jun 22 20:54:41 volumio volumio[3870]: info: MYVolumio Device enabled Jun 22 20:54:41 volumio volumio[3870]: info: [MyVolumio PluginManager] Device activated, enabling myvolumio plugins... Jun 22 20:54:41 volumio volumio[3870]: info: MyVolumio status changed Jun 22 20:54:41 volumio volumio[3870]: info: Streaming services startup Jun 22 20:54:41 volumio volumio[3870]: info: Starting Streaming Daemon Jun 22 20:54:41 volumio volumio[3870]: error: Could not upgrade user account. Error: Device already associated to another id Jun 22 20:54:41 volumio sudo[4410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volumio-streaming-daemon.service Jun 22 20:54:41 volumio volumio[3870]: info: Setting Geolocation for MyVolumio to eu2 Jun 22 20:54:41 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:41 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:41 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:41 volumio sudo[4410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:41 volumio sudo[4410]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:41 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getHwuuid Jun 22 20:54:41 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "bluetooth"... Jun 22 20:54:41 volumio volumio[3870]: info: [1750618481333] Starting BluetoothController Jun 22 20:54:41 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "multiroom"... Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin multiroom Jun 22 20:54:42 volumio sudo[4420]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -rf /tmp/multiroom Jun 22 20:54:42 volumio sudo[4420]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio sudo[4420]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: /bin/mkdir: cannot create directory ‘/tmp/hls’: File exists Jun 22 20:54:42 volumio volumio[3870]: info: MRS: MultiRoom plugin initialized Jun 22 20:54:42 volumio volumio[3870]: info: MRS: STOPPING SNAPCLIENT Jun 22 20:54:42 volumio volumio[3870]: info: MRS: Snap server stop Jun 22 20:54:42 volumio volumio[3870]: info: MRS: STOPPING volumioStreaming Jun 22 20:54:42 volumio sudo[4443]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapclient Jun 22 20:54:42 volumio sudo[4443]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio sudo[4446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioSnapserver Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "metavolumio"... Jun 22 20:54:42 volumio sudo[4452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop volumioStreaming Jun 22 20:54:42 volumio sudo[4446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio sudo[4456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/rm -f /tmp/hls/* Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "manifestui"... Jun 22 20:54:42 volumio sudo[4452]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio sudo[4443]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "cd_controller"... Jun 22 20:54:42 volumio sudo[4456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio sudo[4456]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "smart_inputs"... Jun 22 20:54:42 volumio sudo[4452]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "hi_res_audio"... Jun 22 20:54:42 volumio sudo[4446]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Applying required configuration parameters for plugin hi_res_audio Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "tidal"... Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "qobuz"... Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "tidalconnect"... Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Loading plugin "qobuzconnect"... Jun 22 20:54:42 volumio volumio[3870]: info: Preparing to generate the ALSA configuration file Jun 22 20:54:42 volumio volumio[3870]: info: Updating MyVolumio device info Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 22 20:54:42 volumio volumio[3870]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 22 20:54:42 volumio volumio[3870]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 22 20:54:42 volumio volumio[3870]: info: Reading ALSA contributions from plugins. Jun 22 20:54:42 volumio volumio[3870]: info: Setting Geolocation for MyVolumio to eu2 Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: MRS: Removed streaming files Jun 22 20:54:42 volumio volumio[3870]: info: MRS: volumioStreaming STOPPED Jun 22 20:54:42 volumio volumio[3870]: info: MRS: SNAPSERVER STOPPED Jun 22 20:54:42 volumio volumio[3870]: info: MRS: SNAPCLIENT STOPPED Jun 22 20:54:42 volumio volumio[3870]: error: Cannot start Volumio Streaming Daemon Jun 22 20:54:42 volumio volumio[3870]: error: Failed initialization of streaming services: Error: Error: Command failed: /usr/bin/sudo systemctl restart volumio-streaming-daemon.service Jun 22 20:54:42 volumio volumio[3870]: Failed to restart volumio-streaming-daemon.service: Unit volumio-streaming-daemon.service not found. Jun 22 20:54:42 volumio volumio[3870]: info: Asound.conf file unchanged, so no further update is needed Jun 22 20:54:42 volumio volumio[3870]: info: Output device has changed, restarting MPD Jun 22 20:54:42 volumio volumio[3870]: info: Output device has changed, restarting Shairport Sync Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio sudo[4483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 20:54:42 volumio sudo[4483]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio sudo[4485]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:54:42 volumio sudo[4483]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio sudo[4485]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio volumio[3870]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio systemd[1]: Stopping Music Player Daemon... Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin audio_interface.bluetooth Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin audio_interface.multiroom Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , pushMultiRoomStatus Jun 22 20:54:42 volumio volumio[3870]: info: MRS: Pushing multiroomSync output for this device Jun 22 20:54:42 volumio volumio[3870]: info: MRS: Pushing multiroomSync output Jun 22 20:54:42 volumio volumio[3870]: info: Adding audio output: Jun 22 20:54:42 volumio volumio[3870]: info: Adding audio output: Jun 22 20:54:42 volumio sudo[4505]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/hciconfig hci0 name Volumio Jun 22 20:54:42 volumio volumio[3870]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Jun 22 20:54:42 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:54:42 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:54:42 volumio sudo[4505]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin miscellanea.metavolumio Jun 22 20:54:42 volumio volumio[3870]: info: Adding METAVOLUMIO REST API Endpoints Jun 22 20:54:42 volumio volumio[3870]: info: Adding metavolumio REST Endpoint for plugin: miscellanea/metavolumio Jun 22 20:54:42 volumio volumio[3870]: info: Adding getSimilarArtists REST Endpoint for plugin: miscellanea/metavolumio Jun 22 20:54:42 volumio volumio[3870]: info: Adding getSimilarAlbums REST Endpoint for plugin: miscellanea/metavolumio Jun 22 20:54:42 volumio volumio[3870]: info: Adding getSimilarTracks REST Endpoint for plugin: miscellanea/metavolumio Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin miscellanea.manifestui Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.cd_controller Jun 22 20:54:42 volumio volumio[3870]: info: Preparing CD Folders Jun 22 20:54:42 volumio volumio[3870]: info: Adding CD REST API Endpoints Jun 22 20:54:42 volumio volumio[3870]: info: Adding cdPostRip REST Endpoint for plugin: music_service/cd_controller Jun 22 20:54:42 volumio volumio[3870]: info: Starting UDEV Watcher for CD Jun 22 20:54:42 volumio volumio[3870]: info: Detecting CD presence with UDEV Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: networkfs , getUdevDevices Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.smart_inputs Jun 22 20:54:42 volumio volumio[3870]: info: Adding inputs REST Endpoints Jun 22 20:54:42 volumio volumio[3870]: info: Adding scanAudioInputs REST Endpoint for plugin: music_service/smart_inputs Jun 22 20:54:42 volumio volumio[3870]: info: Scanning Audio Inputs Jun 22 20:54:42 volumio sudo[4509]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:54:42 volumio sudo[4509]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio volumio[3870]: info: Checking against Known Cards name Jun 22 20:54:42 volumio volumio[3870]: info: Checking against Known Cards name Jun 22 20:54:42 volumio sudo[4509]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: Checking against Known Cards name Jun 22 20:54:42 volumio volumio[3870]: info: Adding Server instance for streaming Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.hi_res_audio Jun 22 20:54:42 volumio volumio[3870]: error: Hi Res Audio Failed Login: Missing Login Data Jun 22 20:54:42 volumio volumio[3870]: info: Adding HIGHRESAUDIO REST API Endpoints Jun 22 20:54:42 volumio volumio[3870]: info: Adding getStreamUrlhi_res_audio REST Endpoint for plugin: music_service/hi_res_audio Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.tidal Jun 22 20:54:42 volumio volumio[3870]: info: Refreshing TIDAL token Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuz Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.tidalconnect Jun 22 20:54:42 volumio volumio[3870]: info: [MyVolumio PluginManager] Starting plugin music_service.qobuzconnect Jun 22 20:54:42 volumio volumio[3870]: info: Adding qc_getconfig REST Endpoint for plugin: music_service/qobuzconnect Jun 22 20:54:42 volumio sudo[4526]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Jun 22 20:54:42 volumio volumio[3870]: info: QobuzConnect: Starting Qobuz Connect socket and service Jun 22 20:54:42 volumio sudo[4526]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Jun 22 20:54:42 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Jun 22 20:54:42 volumio systemd[1]: vtcs.service: Succeeded. Jun 22 20:54:42 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Jun 22 20:54:42 volumio sudo[4526]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: QobuzConnect: Opened /tmp/qbz-connect.socket socket, listening for connections Jun 22 20:54:42 volumio volumio[3870]: info: Stopping AccessToken refresher cron for QOBUZ Jun 22 20:54:42 volumio sudo[4536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Jun 22 20:54:42 volumio sudo[4536]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio volumio[3870]: info: AccessToken refresher cron started for QOBUZ Jun 22 20:54:42 volumio volumio[3870]: info: Adding QOBUZ REST API Endpoints Jun 22 20:54:42 volumio volumio[3870]: info: Adding getStreamUrlqobuz REST Endpoint for plugin: music_service/qobuz Jun 22 20:54:42 volumio sudo[4536]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: Successfully Added MyVolumio device Jun 22 20:54:42 volumio volumio[3870]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 22 20:54:42 volumio volumio[3870]: error: Failed to parse min max audio card capabilities, sending default vales: TypeError: Cannot read property 'split' of undefined Jun 22 20:54:42 volumio volumio[3870]: info: MPD Permissions set Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio sudo[4550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Jun 22 20:54:42 volumio sudo[4505]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 22 20:54:42 volumio sudo[4550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:42 volumio volumio[3870]: info: Bluetooth name changed to Volumio Jun 22 20:54:42 volumio volumio[3870]: info: Starting Shairport Sync Jun 22 20:54:42 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Jun 22 20:54:42 volumio qobuz-connect[2344]: 20250622 20:54:42.982 [2344.2344] INFO SampleApp: Stopping Local configuration server Jun 22 20:54:42 volumio volumio[3870]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:42 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:42 volumio volumio[3870]: info: CoreCommandRouter::volumioPause Jun 22 20:54:42 volumio volumio[3870]: info: CoreStateMachine::pause Jun 22 20:54:42 volumio volumio[3870]: info: mpdhttpout --- Volumio set on pause Jun 22 20:54:42 volumio systemd[1]: qobuz-connect.service: Succeeded. Jun 22 20:54:42 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Jun 22 20:54:43 volumio systemd[1]: Started Volumio Qobuz Connect Service. Jun 22 20:54:43 volumio sudo[4550]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:43 volumio volumio[3870]: info: MRS: Found cast device: MAG425A-435fbacb26c0a444fd22ba26849bd0eb Jun 22 20:54:43 volumio volumio[3870]: info: Adding audio output: Jun 22 20:54:43 volumio sudo[4568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:54:43 volumio sudo[4568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:43 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 20:54:43 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 20:54:43 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:43 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 20:54:43 volumio sudo[4568]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:43 volumio volumio[3870]: info: Executing endpoint qc_getconfig Jun 22 20:54:43 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.105 [4567.4567] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.109 [4567.4567] INFO VolumeManager: [0x812f9908]: Setting new playback volume: 75 Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.110 [4567.4567] INFO VolumeManager: [0x812f9908]: Setting new mute state: 0 Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.110 [4567.4567] INFO QobuzConnect: [0x812fa2d8]: Client initialized! Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.110 [4567.4567] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Jun 22 20:54:43 volumio volumio[3870]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Jun 22 20:54:43 volumio volumio[3870]: info: QobuzConnect: QOBUZ Connect daemon connected Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.118 [4567.4567] INFO LocalConfigManager: [0x812f91e8]: Starting Local Configuration server Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.118 [4567.4567] INFO SampleApp: Starting Local configuration server Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.119 [4567.4567] INFO SampleApp: Connected to UNIX socket client 0x812eeed8 Jun 22 20:54:43 volumio volumio[3870]: info: Shairport-Sync Started Jun 22 20:54:43 volumio volumio[3870]: error: No access token received for TIDAL Jun 22 20:54:43 volumio volumio[3870]: info: Successfully Updated MyVolumio device Jun 22 20:54:43 volumio volumio[3870]: info: Successfully Added MyVolumio device Jun 22 20:54:43 volumio qobuz-connect[4567]: 20250622 20:54:43.255 [4567.4567] INFO SampleApp: Playback volume changed: 75 Jun 22 20:54:43 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:43 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:43 volumio volumio[3870]: info: Updating MyVolumio device info Jun 22 20:54:43 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:43 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:43 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:43 volumio mpd[4539]: Jun 22 20:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 22 20:54:43 volumio systemd[1]: Started Music Player Daemon. Jun 22 20:54:43 volumio sudo[4485]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:43 volumio volumio[3870]: error: updateQueue error: null Jun 22 20:54:43 volumio volumio[3870]: info: Successfully Updated MyVolumio device Jun 22 20:54:44 volumio volumio[3870]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jun 22 20:54:44 volumio volumio[3870]: info: FusionDsp - Stopping FusionDsp service Jun 22 20:54:44 volumio volumio[3870]: info: camilladsp stopping service pid 4242... Jun 22 20:54:44 volumio volumio[3870]: info: camilladsp service terminated, instance 1 Jun 22 20:54:44 volumio sudo[4593]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop fusiondsp.service Jun 22 20:54:44 volumio sudo[4593]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:44 volumio volumio[4259]: Backend configuration: Jun 22 20:54:44 volumio volumio[4259]: active_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jun 22 20:54:44 volumio volumio[4259]: active_config_txt: null Jun 22 20:54:44 volumio volumio[4259]: camilla_host: 127.0.0.1 Jun 22 20:54:44 volumio volumio[4259]: camilla_port: 9876 Jun 22 20:54:44 volumio volumio[4259]: coeff_dir: /data/INTERNAL/FusionDsp/filters Jun 22 20:54:44 volumio volumio[4259]: config_dir: /data/configuration/audio_interface/fusiondsp Jun 22 20:54:44 volumio volumio[4259]: default_config: /data/configuration/audio_interface/fusiondsp/camilladsp.yml Jun 22 20:54:44 volumio volumio[4259]: log_file: /tmp/camilladsp.log Jun 22 20:54:44 volumio volumio[4259]: on_get_active_config: null Jun 22 20:54:44 volumio volumio[4259]: on_set_active_config: null Jun 22 20:54:44 volumio volumio[4259]: port: 5011 Jun 22 20:54:44 volumio volumio[4259]: supported_capture_types: null Jun 22 20:54:44 volumio volumio[4259]: supported_playback_types: null Jun 22 20:54:44 volumio volumio[4259]: update_config_symlink: false Jun 22 20:54:44 volumio volumio[4259]: update_config_txt: false Jun 22 20:54:44 volumio volumio[4259]: ======== Running on http://0.0.0.0:5011 ======== Jun 22 20:54:44 volumio volumio[4259]: (Press CTRL+C to quit) Jun 22 20:54:44 volumio systemd[1]: Stopping FusionDsp Daemon... Jun 22 20:54:44 volumio systemd[1]: fusiondsp.service: Succeeded. Jun 22 20:54:44 volumio systemd[1]: Stopped FusionDsp Daemon. Jun 22 20:54:44 volumio sudo[4593]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:44 volumio volumio[3870]: info: FusionDsp - Reporting Fusion DSP Disabled Jun 22 20:54:44 volumio volumio[3870]: info: Removing fusiondspeq DSP Signal Path Element Jun 22 20:54:44 volumio volumio[3870]: info: Check plugin dependencies Jun 22 20:54:44 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:54:44 volumio volumio[3870]: info: Rename folder Jun 22 20:54:44 volumio volumio[3870]: info: Folder /tmp/downloaded_plugin.zip removed Jun 22 20:54:44 volumio volumio[3870]: info: Move to category Jun 22 20:54:45 volumio volumio[3870]: info: Checking if install.sh is present Jun 22 20:54:45 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jun 22 20:54:45 volumio volumio[3870]: info: Executing install.sh Jun 22 20:54:45 volumio sudo[4614]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:54:45 volumio sudo[4614]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:45 volumio systemd[1]: Stopping Music Player Daemon... Jun 22 20:54:45 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:54:45 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:54:45 volumio sudo[4621]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Jun 22 20:54:45 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:54:45 volumio sudo[4621]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:45 volumio volumio[3870]: info: creating filters folder and copying demo filters Jun 22 20:54:45 volumio volumio[3870]: info: copying demo flters Jun 22 20:54:45 volumio sudo[4625]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:54:45 volumio sudo[4625]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:45 volumio sudo[4625]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/ Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/2XEQ15/ Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/2XEQ15/.Bass-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/2XEQ15/.Soundtrack-FusionDsp.json Jun 22 20:54:45 volumio sudo[4661]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt update Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/2XEQ15/.Classic-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/2XEQ15/.Voice-FusionDsp.json Jun 22 20:54:45 volumio sudo[4661]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/2XEQ15/.Rock-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/PEQ/ Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/convfir/ Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/convfir/kef.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/convfir/test.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/EQ15/ Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/EQ15/.Bass-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/EQ15/.Soundtrack-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/EQ15/.Classic-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/EQ15/.Voice-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: ./presets/EQ15/.Rock-FusionDsp.json Jun 22 20:54:45 volumio volumio[3870]: info: Installing/fusiondsp dependencies Jun 22 20:54:45 volumio sudo[4674]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumiobt.service Jun 22 20:54:45 volumio sudo[4674]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:45 volumio volumio[3870]: info: Hit:1 http://deb.debian.org/debian buster InRelease Jun 22 20:54:45 volumio sudo[4674]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:45 volumio volumio[3870]: info: Get:2 https://deb.nodesource.com/node_14.x buster InRelease [4584 B] Jun 22 20:54:45 volumio volumio[3870]: info: Volumio BT Module successfully started Jun 22 20:54:45 volumio volumio[3870]: info: TidalConnect service stoped! Jun 22 20:54:45 volumio volumio[3870]: info: Adding tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Jun 22 20:54:45 volumio volumio[3870]: info: Adding tc_connect REST Endpoint for plugin: music_service/tidalconnect Jun 22 20:54:45 volumio sudo[4723]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart sshtunnel.service Jun 22 20:54:45 volumio sudo[4737]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Jun 22 20:54:45 volumio sudo[4723]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:45 volumio sudo[4737]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:45 volumio systemd[1]: Stopping MyVolumio SSH Tunnel... Jun 22 20:54:46 volumio autossh[2403]: received signal to exit (15) Jun 22 20:54:46 volumio systemd[1]: sshtunnel.service: Main process exited, code=killed, status=15/TERM Jun 22 20:54:46 volumio systemd[1]: sshtunnel.service: Succeeded. Jun 22 20:54:46 volumio systemd[1]: Stopped MyVolumio SSH Tunnel. Jun 22 20:54:46 volumio volumio[3870]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 22 20:54:46 volumio volumio[3870]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 22 20:54:46 volumio systemd[1]: Started MyVolumio SSH Tunnel. Jun 22 20:54:46 volumio sudo[4723]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:46 volumio systemd[1]: Started Volumio Tidal Connect Service. Jun 22 20:54:46 volumio sudo[4737]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:46 volumio autossh[4773]: port set to 0, monitoring disabled Jun 22 20:54:46 volumio autossh[4773]: starting ssh (count 1) Jun 22 20:54:46 volumio autossh[4773]: ssh child pid is 4791 Jun 22 20:54:46 volumio volumio[3870]: info: Remote SSH Started Jun 22 20:54:46 volumio volumiossh-tunnel[4763]: Warning: Permanently added '[eu2.myvolumio.org]:2222,[185.14.187.123]:2222' (RSA) to the list of known hosts. Jun 22 20:54:46 volumio volumio[3870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 10 Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:46 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:46 volumio volumio[3870]: info: Executing endpoint tc_getconfig Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Jun 22 20:54:46 volumio vtcs[4770]: STARTING TidalConnect services, version: 1.5.1-beta1 Jun 22 20:54:46 volumio vtcs[4770]: STARTED TidalConnect services. Jun 22 20:54:46 volumio volumio[3870]: info: Executing endpoint tc_connect Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Jun 22 20:54:46 volumio volumio[3870]: info: Connecting to TidalConnect Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::servicePushState Jun 22 20:54:46 volumio volumio[3870]: info: CoreStateMachine::pushState Jun 22 20:54:46 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::volumioPushState Jun 22 20:54:46 volumio volumio[3870]: info: MRS: Pushing multiroomSync output update for this device Jun 22 20:54:46 volumio volumio[3870]: info: MRS: Pushing multiroomSync output Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:46 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:46 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:46 volumio volumio[3870]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::servicePushState Jun 22 20:54:46 volumio volumio[3870]: info: CoreStateMachine::pushState Jun 22 20:54:46 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::volumioPushState Jun 22 20:54:46 volumio volumio[3870]: info: MRS: Pushing multiroomSync output update for this device Jun 22 20:54:46 volumio volumio[3870]: info: MRS: Pushing multiroomSync output Jun 22 20:54:46 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:46 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:46 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:46 volumio volumio[3870]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current mpd Received tidalconnect Jun 22 20:54:46 volumio volumio[4326]: ............................................................................................................................++++ Jun 22 20:54:46 volumio volumio[4326]: e is 65537 (0x010001) Jun 22 20:54:46 volumio volumio[4326]: writing RSA key Jun 22 20:54:46 volumio volumio[3870]: info: Fetched 4584 B in 1s (4377 B/s) Jun 22 20:54:46 volumio mpd[4663]: Jun 22 20:54 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 22 20:54:46 volumio systemd[1]: Started Music Player Daemon. Jun 22 20:54:46 volumio sudo[4614]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:46 volumio volumio[3870]: error: updateQueue error: null Jun 22 20:54:47 volumio volumio[3870]: info: MRS: Getting audio outputs on start Jun 22 20:54:47 volumio volumio[3870]: info: MRS: Requesting all other devices output Jun 22 20:54:49 volumio volumio[3870]: info: TidalConnect service started! Jun 22 20:54:49 volumio volumio[3870]: [Metrics] CommandRouter: 24s 479.28ms Jun 22 20:54:49 volumio volumio[3870]: info: CoreCommandRouter::volumiosetStartupVolume Jun 22 20:54:49 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:49 volumio volumio[3870]: info: VolumeController:: Setting startup Volume 20 Jun 22 20:54:49 volumio volumio[3870]: info: VolumeController::SetAlsaVolume20 Jun 22 20:54:49 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:49 volumio volumio[3870]: info: CoreCommandRouter::Close All Modals sent Jun 22 20:54:49 volumio volumio[3870]: info: CoreCommandRouter::Close All Modals sent Jun 22 20:54:49 volumio volumio[3870]: info: CoreStateMachine::pushState Jun 22 20:54:49 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:49 volumio volumio[3870]: info: CoreCommandRouter::volumioPushState Jun 22 20:54:49 volumio volumio[3870]: info: MRS: Pushing multiroomSync output update for this device Jun 22 20:54:49 volumio volumio[3870]: info: MRS: Pushing multiroomSync output Jun 22 20:54:49 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:49 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:49 volumio volumio[3870]: info: Reading package lists... Jun 22 20:54:49 volumio volumio[3870]: info: Building dependency tree... Jun 22 20:54:49 volumio volumio[3870]: info: Reading state information... Jun 22 20:54:49 volumio volumio[3870]: info: All packages are up to date. Jun 22 20:54:49 volumio sudo[4661]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:49 volumio sudo[4998]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Jun 22 20:54:49 volumio sudo[4998]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:49 volumio volumio[3870]: info: FusionDsp - ---- read samplerate, raw: 44100,S32_LE,2,32 Jun 22 20:54:49 volumio volumio[3870]: info: FusionDsp - ---- read samplerate from file: 44100 Jun 22 20:54:49 volumio volumio[3870]: error: FusionDsp - TypeError: Cannot read property 'stop' of null Jun 22 20:54:49 volumio volumio[3870]: info: Reading package lists... Jun 22 20:54:50 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , checkAudioDeviceAvailable Jun 22 20:54:50 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getI2sStatus Jun 22 20:54:50 volumio volumio[3870]: xcb_connection_has_error() returned true Jun 22 20:54:50 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , versionChangeDetect Jun 22 20:54:50 volumio volumio[3870]: info: Building dependency tree... Jun 22 20:54:50 volumio volumio[3870]: info: Reading state information... Jun 22 20:54:51 volumio sudo[4998]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:51 volumio volumio[3870]: info: python3-aiohttp is already the newest version (3.5.1-1+deb10u1). Jun 22 20:54:51 volumio volumio[3870]: info: python3-pip is already the newest version (18.1-5). Jun 22 20:54:51 volumio volumio[3870]: info: 0 upgraded, 0 newly installed, 0 to remove and 0 not upgraded. Jun 22 20:54:51 volumio sudo[5017]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/tar -xvf fusiondsp.service.tar -C / Jun 22 20:54:51 volumio sudo[5017]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:51 volumio volumio[3870]: info: lib/systemd/system/fusiondsp.service Jun 22 20:54:51 volumio sudo[5017]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:53 volumio volumio[3870]: info: Downloading plugin at https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jun 22 20:54:53 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Jun 22 20:54:53 volumio volumio[3870]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 11 Jun 22 20:54:53 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:53 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:56 volumio volumio[3870]: info: BOOT COMPLETED Jun 22 20:54:56 volumio volumio[3870]: info: MiniUnz 1.01b, demo of zLib + Unz package written by Gilles Vollant Jun 22 20:54:56 volumio volumio[3870]: info: more info at http://www.winimage.com/zLibDll/unzip.html Jun 22 20:54:56 volumio volumio[3870]: info: Jun 22 20:54:56 volumio sudo[5044]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chown -R volumio cgui Jun 22 20:54:56 volumio volumio[3870]: info: cgui-1.0.0.zip opened Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/LICENSE.txt Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/README.md Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/build/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/robots.txt Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/logo512.png Jun 22 20:54:56 volumio sudo[5044]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/asset-manifest.json Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/index.html Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/.put_statics_here Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/favicon.ico Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/logo192.png Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/.xdp-css-variables-1.css-PvrWoX Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/manifest.json Jun 22 20:54:56 volumio sudo[5044]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/css-variables.css Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/precache-manifest.76db5aad1647230454f47b1e22783b54.js Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/service-worker.js Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/precache-manifest.5e6c675b70ef6a3fe73d0209febfe347.js Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/build/static/ Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/build/static/css/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/main.d51d005e.chunk.css.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/main.56bdf14e.chunk.css.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/main.1503f6cd.css.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/main.1503f6cd.css Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/2.975d6916.chunk.css Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/css/2.a4c7e7cf.chunk.css Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/build/static/media/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/media/camilladsp.95719842.svg Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/media/camilladsp.4767ea4ad3510467418b818dc677a87e.svg Jun 22 20:54:56 volumio sudo[5053]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/chgrp -R volumio cgui Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/build/static/js/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/main.71e11955.js Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.LICENSE.txt Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js Jun 22 20:54:56 volumio sudo[5053]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/main.61bb6809.chunk.js.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/main.71e11955.js.LICENSE.txt Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/main.71e11955.js.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/runtime-main.422581ec.js.map Jun 22 20:54:56 volumio sudo[5053]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/main.1b3ac690.chunk.js Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/2.c1b9df8b.chunk.js.map Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/build/static/js/2.fd49ece5.chunk.js.LICENSE.txt Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/config/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/config/camillagui.yml Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/config/.xdp-css-variables-1.css-ppBDuX Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/config/gui-config.yml Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/backend/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/filters_test.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/version.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/filters.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/settings.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/views.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/filterdefaults.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__init__.py Jun 22 20:54:56 volumio volumio[3870]: info: creating directory: cgui/backend/__pycache__/ Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/filterdefaults.cpython-37.pyc Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/views.cpython-37.pyc Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/settings.cpython-37.pyc Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/__init__.cpython-37.pyc Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/routes.cpython-37.pyc Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/filemanagement.cpython-37.pyc Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/filters.cpython-37.pyc Jun 22 20:54:56 volumio sudo[5062]: root : TTY=unknown ; PWD=/data/plugins/audio_interface/fusiondsp ; USER=root ; COMMAND=/bin/rm cgui-1.0.0.zip Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/__pycache__/version.cpython-37.pyc Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/routes.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/backend/filemanagement.py Jun 22 20:54:56 volumio volumio[3870]: info: extracting: cgui/main.py Jun 22 20:54:56 volumio sudo[5062]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:56 volumio sudo[5062]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:56 volumio volumio[3870]: info: mpdhttpout ---Boot completed detected! Patching mpd now! Jun 22 20:54:56 volumio volumio[3870]: info: mpdhttpout ---Configuration successfully replaced in mpd.conf. Jun 22 20:54:56 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:54:56 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:54:56 volumio volumio[3870]: info: CoreCommandRouter::volumioPause Jun 22 20:54:56 volumio volumio[3870]: info: CoreStateMachine::pause Jun 22 20:54:56 volumio volumio[3870]: info: mpdhttpout --- Volumio set on pause Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 22 20:54:58 volumio volumio-remote-updater[539]: No test mode Jun 22 20:54:58 volumio volumio-remote-updater[539]: No alpha test mode Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateEnabled Jun 22 20:54:58 volumio volumio[3870]: info: Update Ready: {"changeLogLink":"","description":"You're already on the latest version","title":"No Updates Available","updateavailable":false} Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: updater_comm , setUpdateMessageCache Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: i2s_dacs , getConfigParam Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: appearance , getConfigParam Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: mpd , getMyCollectionStatsObject Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::volumioGetBrowseSources Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:54:58 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: mpd , restartMpd Jun 22 20:54:58 volumio sudo[5076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:54:58 volumio sudo[5076]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:59 volumio systemd[1]: Stopping Music Player Daemon... Jun 22 20:54:59 volumio volumio[3870]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 22 20:54:59 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:54:59 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:54:59 volumio volumio[3870]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Jun 22 20:54:59 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:54:59 volumio volumio[3870]: ------------------------------------ BT MESSAGE: BT STATUS: running Jun 22 20:54:59 volumio sudo[5082]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:54:59 volumio sudo[5082]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:54:59 volumio sudo[5082]: pam_unix(sudo:session): session closed for user root Jun 22 20:54:59 volumio volumio[3870]: info: Collecting git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 Jun 22 20:54:59 volumio volumio[3870]: info: Cloning https://github.com/HEnquist/pycamilladsp.git (to revision v1.0.0) to /tmp/pip-req-build-2cgoyky0 Jun 22 20:55:00 volumio mpd[5091]: Jun 22 20:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 22 20:55:00 volumio systemd[1]: Started Music Player Daemon. Jun 22 20:55:00 volumio sudo[5076]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:00 volumio volumio[3870]: error: updateQueue error: null Jun 22 20:55:01 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 22 20:55:01 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 22 20:55:01 volumio volumio[3870]: info: Discovery: Getting this device information Jun 22 20:55:01 volumio volumio[3870]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:01 volumio volumio[3870]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:01 volumio volumio[3870]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:55:02 volumio volumio[3870]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp==1.0.0 from git+https://github.com/HEnquist/pycamilladsp.git@v1.0.0 in /usr/local/lib/python3.7/dist-packages Jun 22 20:55:02 volumio volumio[3870]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (6.0) Jun 22 20:55:02 volumio volumio[3870]: info: Requirement already satisfied: websocket_client in /usr/local/lib/python3.7/dist-packages (from camilladsp==1.0.0) (1.5.1) Jun 22 20:55:02 volumio volumio[3870]: info: Building wheels for collected packages: camilladsp Jun 22 20:55:02 volumio volumio[3870]: info: Running setup.py bdist_wheel for camilladsp: started Jun 22 20:55:02 volumio volumio[3870]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Jun 22 20:55:02 volumio volumio[3870]: info: FusionDsp - Stopping FusionDsp service Jun 22 20:55:02 volumio volumio[3870]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 20:55:02 volumio volumio[3870]: TypeError: Cannot read property 'stop' of null Jun 22 20:55:02 volumio volumio[3870]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:109:23) Jun 22 20:55:02 volumio volumio[3870]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 22 20:55:02 volumio volumio[3870]: at /volumio/app/pluginmanager.js:956:12 Jun 22 20:55:02 volumio volumio[3870]: at ChildProcess.exithandler (child_process.js:374:7) Jun 22 20:55:02 volumio volumio[3870]: at ChildProcess.emit (events.js:400:28) Jun 22 20:55:02 volumio volumio[3870]: at maybeClose (internal/child_process.js:1088:16) Jun 22 20:55:02 volumio volumio[3870]: at Socket. (internal/child_process.js:446:11) Jun 22 20:55:02 volumio volumio[3870]: at Socket.emit (events.js:400:28) Jun 22 20:55:02 volumio volumio[3870]: at Pipe. (net.js:686:12) Jun 22 20:55:02 volumio volumio[3870]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 20:55:03 volumio sudo[5127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-22 20:54 Jun 22 20:55:03 volumio sudo[5127]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:03 volumio sudo[5127]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:03 volumio vtcs[4770]: [2025-06-22 20:55:03.204] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Jun 22 20:55:03 volumio volumio-remote-updater[539]: [2025-06-22 20:55:03] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 22 20:55:03 volumio volumio-remote-updater[539]: [2025-06-22 20:55:03] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 22 20:55:03 volumio sudo[4621]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:03 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 22 20:55:03 volumio qobuz-connect[4567]: 20250622 20:55:03.207 [4567.4567] INFO SampleApp: Socket closed Jun 22 20:55:03 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 22 20:55:03 volumio systemd[1]: Started dynamicswap service. Jun 22 20:55:03 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 22 20:55:03 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 22 20:55:03 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 2. Jun 22 20:55:03 volumio systemd[1]: Stopped Volumio Backend Module. Jun 22 20:55:03 volumio systemd[1]: Started Volumio Backend Module. Jun 22 20:55:03 volumio systemd[1]: Started dynamicswap service. Jun 22 20:55:03 volumio systemd[1]: dynamicswap.service: Succeeded. Jun 22 20:55:04 volumio volumio[5149]: info: ------------------------------------------- Jun 22 20:55:04 volumio volumio[5149]: info: ----- Volumio3 ---- Jun 22 20:55:04 volumio volumio[5149]: info: ------------------------------------------- Jun 22 20:55:04 volumio volumio[5149]: info: ----- System startup ---- Jun 22 20:55:04 volumio volumio[5149]: info: ------------------------------------------- Jun 22 20:55:04 volumio volumio[5149]: info: MYVOLUMIO Environment detected Jun 22 20:55:04 volumio volumio[5149]: info: Plugin folders cleanup Jun 22 20:55:04 volumio volumio[5149]: info: Scanning into folder /volumio/app/plugins/ Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category audio_interface Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category miscellanea Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category music_service Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category plugins.json Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category system_controller Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category user_interface Jun 22 20:55:04 volumio volumio[5149]: info: Scanning into folder /data/plugins/ Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category audio_interface Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category music_service Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category system_controller Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category system_hardware Jun 22 20:55:04 volumio volumio[5149]: info: Scanning category user_interface Jun 22 20:55:04 volumio volumio[5149]: info: Plugin folders cleanup completed Jun 22 20:55:04 volumio volumio[5149]: info: ------------------------------------------- Jun 22 20:55:04 volumio volumio[5149]: info: ----- Core plugins startup ---- Jun 22 20:55:04 volumio volumio[5149]: info: ------------------------------------------- Jun 22 20:55:04 volumio volumio[5149]: info: Loading plugins from folder /volumio/app/plugins/ Jun 22 20:55:04 volumio volumio[5149]: info: Adding plugin upnp to MyMusic Plugins Jun 22 20:55:04 volumio volumio[5149]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 22 20:55:04 volumio volumio[5149]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 22 20:55:04 volumio volumio[5149]: info: Loading plugins from folder /data/plugins/ Jun 22 20:55:04 volumio volumio[5149]: info: Loading plugin "system"... Jun 22 20:55:04 volumio volumio[5149]: info: Loading plugin "appearance"... Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "network"... Jun 22 20:55:05 volumio volumio[5149]: info: Refreshing Cached IP Addresses Jun 22 20:55:05 volumio sudo[5176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 22 20:55:05 volumio sudo[5176]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "services"... Jun 22 20:55:05 volumio sudo[5178]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "alsa_controller"... Jun 22 20:55:05 volumio sudo[5176]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:05 volumio sudo[5178]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:05 volumio sudo[5195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 22 20:55:05 volumio sudo[5178]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:05 volumio sudo[5195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:05 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "wizard"... Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "networkfs"... Jun 22 20:55:05 volumio volumio[5149]: info: Starting Udev Watcher for removable devices Jun 22 20:55:05 volumio volumio[5149]: info: Ignoring mount for partition: boot Jun 22 20:55:05 volumio volumio[5149]: info: Ignoring mount for partition: volumio Jun 22 20:55:05 volumio volumio[5149]: info: Ignoring mount for partition: volumio_data Jun 22 20:55:05 volumio volumio[5149]: info: Ignoring mount for partition: boot Jun 22 20:55:05 volumio volumio[5149]: info: Ignoring mount for partition: volumio Jun 22 20:55:05 volumio volumio[5149]: info: Ignoring mount for partition: volumio_data Jun 22 20:55:05 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "volumio_command_line_client"... Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "upnp"... Jun 22 20:55:05 volumio volumio[5149]: info: [1750618505666] Starting Upmpd Daemon Jun 22 20:55:05 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "my_music"... Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "mpd"... Jun 22 20:55:05 volumio volumio[5149]: info: Loading plugin "upnp_browser"... Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "alarm-clock"... Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "airplay_emulation"... Jun 22 20:55:06 volumio volumio[5149]: info: Starting Shairport Sync Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "last_100"... Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "webradio"... Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "i2s_dacs"... Jun 22 20:55:06 volumio volumio[5149]: info: I2S DAC not set, start Auto-detection Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "volumiodiscovery"... Jun 22 20:55:06 volumio volumio[5149]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 20:55:06 volumio volumio[5149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:55:06 volumio volumio[5149]: *** WARNING *** For more information see Jun 22 20:55:06 volumio volumio[5149]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 20:55:06 volumio node[5149]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 22 20:55:06 volumio volumio[5149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:55:06 volumio volumio[5149]: *** WARNING *** For more information see Jun 22 20:55:06 volumio node[5149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:55:06 volumio node[5149]: *** WARNING *** For more information see Jun 22 20:55:06 volumio node[5149]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 22 20:55:06 volumio node[5149]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 22 20:55:06 volumio node[5149]: *** WARNING *** For more information see Jun 22 20:55:06 volumio volumio[5149]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 22 20:55:06 volumio volumio[5149]: info: Discovery: Started advertising with name: Volumio Jun 22 20:55:06 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 22 20:55:06 volumio volumio[5149]: info: Plugin gpio-buttons is not enabled Jun 22 20:55:06 volumio volumio[5149]: info: Plugin now_playing is not enabled Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "outputs"... Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "albumart"... Jun 22 20:55:06 volumio volumio[5149]: info: Plugin example_plugin is not enabled Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "inputs"... Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "updater_comm"... Jun 22 20:55:06 volumio volumio[5149]: info: Plugin mpdemulation is not enabled Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "rest_api"... Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "websocket"... Jun 22 20:55:06 volumio volumio[5149]: info: Starting Socket.io Server version 2.3.0 Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "fusiondsp"... Jun 22 20:55:06 volumio volumio[5149]: Forking 3 albumart workers Jun 22 20:55:06 volumio volumio[5149]: info: Applying required configuration parameters for plugin fusiondsp Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "mpdoutput"... Jun 22 20:55:06 volumio volumio[5149]: info: Plugin minidlna is not enabled Jun 22 20:55:06 volumio volumio[5149]: info: Plugin backup_restore is not enabled Jun 22 20:55:06 volumio volumio[5149]: info: Loading plugin "gpio_control"... Jun 22 20:55:06 volumio sudo[5195]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:07 volumio volumio[5149]: error: !!!! WARNING !!!! Jun 22 20:55:07 volumio volumio[5149]: error: The plugin system_hardware/gpio_control failed to load, setting it to stopped. Error: TypeError: Cannot read property '0' of null Jun 22 20:55:07 volumio volumio[5149]: error: Stack trace: TypeError: Cannot read property '0' of null Jun 22 20:55:07 volumio volumio[5149]: at GPIOControl.getPiBoardInfo (/data/plugins/system_hardware/gpio_control/index.js:511:12) Jun 22 20:55:07 volumio volumio[5149]: at new GPIOControl (/data/plugins/system_hardware/gpio_control/index.js:35:22) Jun 22 20:55:07 volumio volumio[5149]: at PluginManager.loadCorePlugin (/volumio/app/pluginmanager.js:235:24) Jun 22 20:55:07 volumio volumio[5149]: at /volumio/app/pluginmanager.js:338:34 Jun 22 20:55:07 volumio volumio[5149]: at Array.forEach () Jun 22 20:55:07 volumio volumio[5149]: at HashMap. (/volumio/app/pluginmanager.js:337:20) Jun 22 20:55:07 volumio volumio[5149]: at HashMap.forEach (/volumio/node_modules/hashmap/hashmap.js:171:10) Jun 22 20:55:07 volumio volumio[5149]: at HashMap.proto. [as forEach] (/volumio/node_modules/hashmap/hashmap.js:201:7) Jun 22 20:55:07 volumio volumio[5149]: at PluginManager.loadCorePlugins (/volumio/app/pluginmanager.js:335:18) Jun 22 20:55:07 volumio volumio[5149]: at PluginManager.startPlugins (/volumio/app/pluginmanager.js:102:26) Jun 22 20:55:07 volumio volumio[5149]: at new CoreCommandRouter (/volumio/app/index.js:48:42) Jun 22 20:55:07 volumio volumio[5149]: at Object. (/volumio/index.js:54:21) Jun 22 20:55:07 volumio volumio[5149]: at Module._compile (internal/modules/cjs/loader.js:1114:14) Jun 22 20:55:07 volumio volumio[5149]: at Object.Module._extensions..js (internal/modules/cjs/loader.js:1143:10) Jun 22 20:55:07 volumio volumio[5149]: at Module.load (internal/modules/cjs/loader.js:979:32) Jun 22 20:55:07 volumio volumio[5149]: at Function.Module._load (internal/modules/cjs/loader.js:819:12) Jun 22 20:55:07 volumio volumio[5149]: error: !!!! WARNING !!!! Jun 22 20:55:07 volumio volumio[5149]: info: Loading i18n strings for locale pl Jun 22 20:55:07 volumio volumio[5149]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jun 22 20:55:07 volumio volumio[5149]: Updating browse sources language Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:55:07 volumio volumio[5149]: Starting albumart workers Jun 22 20:55:07 volumio volumio[5149]: Starting albumart workers Jun 22 20:55:07 volumio volumio[5149]: Starting albumart workers Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::initPlayerControls Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: Express server listening on port 3000 Jun 22 20:55:07 volumio volumio[5149]: [Metrics] WebUI: 3s 245.92ms Jun 22 20:55:07 volumio volumio[5149]: info: CoreStateMachine::resetVolumioState Jun 22 20:55:07 volumio volumio[5149]: info: CoreStateMachine::getcurrentVolume Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioRetrievevolume Jun 22 20:55:07 volumio volumio[5149]: info: CoreStateMachine::pushState Jun 22 20:55:07 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioPushState Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jun 22 20:55:07 volumio volumio[5149]: info: Completed loading Core Plugins Jun 22 20:55:07 volumio volumio[5149]: info: Preparing to generate the ALSA configuration file Jun 22 20:55:07 volumio volumio[5149]: info: Volumio Network Manager: Network status updated: 1 Jun 22 20:55:07 volumio volumio[5149]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 22 20:55:07 volumio volumio[5149]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 22 20:55:07 volumio volumio[5149]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 22 20:55:07 volumio volumio[5149]: info: Reading ALSA contributions from plugins. Jun 22 20:55:07 volumio volumio[5149]: verbose: New Socket.io Connection to 192.168.2.13 from 192.168.2.3 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.91 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 22 20:55:07 volumio volumio[5149]: verbose: New Socket.io Connection to 192.168.2.13:3000 from 192.168.2.3 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Jun 22 20:55:07 volumio volumio[5149]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jun 22 20:55:07 volumio volumio[5149]: info: Reloading queue from file Jun 22 20:55:07 volumio volumio[5149]: info: CoreStateMachine::setRepeat null single undefined Jun 22 20:55:07 volumio volumio[5149]: info: CoreStateMachine::pushState Jun 22 20:55:07 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioPushState Jun 22 20:55:07 volumio volumio[5149]: info: CoreStateMachine::setRandom null Jun 22 20:55:07 volumio volumio[5149]: info: CoreStateMachine::pushState Jun 22 20:55:07 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioPushState Jun 22 20:55:07 volumio volumio[5149]: info: Setting Device type: Tinkerboard Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 22 20:55:07 volumio volumio[5149]: info: Discovery: Getting this device information Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:07 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:55:07 volumio volumio[5149]: info: Discovery: adding e32e0ba1-1a29-4a33-86a1-56d38ac2a3c2 Jun 22 20:55:07 volumio volumio[5149]: info: Discovery: Found device Volumio Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:07 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:07 volumio volumio[5149]: verbose: New Socket.io Connection to 192.168.2.13 from 192.168.2.3 UA: Mozilla/5.0 (Linux; Android 15; SM-G998B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/137.0.7151.91 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 22 20:55:07 volumio volumio[5149]: info: Asound.conf file unchanged, so no further update is needed Jun 22 20:55:07 volumio volumio[5149]: info: Output device has changed, restarting MPD Jun 22 20:55:07 volumio volumio[5149]: info: Output device has changed, restarting Shairport Sync Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:07 volumio sudo[5292]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 20:55:07 volumio sudo[5295]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:55:07 volumio sudo[5292]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:07 volumio sudo[5295]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:07 volumio sudo[5292]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:07 volumio volumio[5149]: info: ___________ START PLUGINS ___________ Jun 22 20:55:07 volumio volumio[5149]: info: ControllerMpd::onStart: Initializing MPD Jun 22 20:55:07 volumio volumio[5149]: info: Creating MPD Configuration file Jun 22 20:55:07 volumio systemd[1]: Stopping Music Player Daemon... Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 20:55:07 volumio volumio[5149]: info: [1750618507886] CoreMusicLibrary::Adding element Serwery Mediów Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:55:07 volumio sudo[5313]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 20:55:07 volumio sudo[5314]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:07 volumio sudo[5313]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:07 volumio sudo[5314]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:07 volumio sudo[5313]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:07 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:55:07 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:55:07 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:07 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 22 20:55:07 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:55:07 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:55:07 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 20:55:07 volumio volumio[5149]: info: [1750618507976] CoreMusicLibrary::Adding element Last_100 Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 22 20:55:07 volumio volumio[5149]: info: [1750618507978] CoreMusicLibrary::Adding element Webradio Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:55:07 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:55:07 volumio volumio[5149]: info: Initializing BBC Radios Jun 22 20:55:08 volumio sudo[5333]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:08 volumio sudo[5333]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:08 volumio volumio[5149]: info: Loading i18n strings for locale pl Jun 22 20:55:08 volumio volumio[5149]: info: Plugin mpdoutput has duplicated i18n key SAVE. It is ignored. Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: FusionDsp - mixtype--------------------- None Jun 22 20:55:08 volumio sudo[5333]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:08 volumio volumio[5149]: info: Volumio Calling Home Jun 22 20:55:08 volumio volumio[5149]: info: Preparing to generate the ALSA configuration file Jun 22 20:55:08 volumio volumio[5149]: verbose: New Socket.io Connection to 192.168.2.13:3000 from 192.168.2.3 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jun 22 20:55:08 volumio volumio[5149]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf Jun 22 20:55:08 volumio volumio[5149]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Jun 22 20:55:08 volumio volumio[5149]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 22 20:55:08 volumio volumio[5149]: info: Reading ALSA contributions from plugins. Jun 22 20:55:08 volumio volumio-remote-updater[539]: [2025-06-22 20:55:08] [connect] Successful connection Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:08 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 22 20:55:08 volumio volumio[5149]: info: Volumio called home Jun 22 20:55:08 volumio volumio[5149]: info: MPD Permissions set Jun 22 20:55:08 volumio volumio[5149]: info: MPD Permissions set Jun 22 20:55:08 volumio volumio-remote-updater[539]: [2025-06-22 20:55:08] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1750618508 101 Jun 22 20:55:08 volumio volumio[5149]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 6 Jun 22 20:55:08 volumio volumio[5149]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::volumioGetVisibleSources Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:08 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 22 20:55:08 volumio volumio[5149]: info: Received Get System Info Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 22 20:55:08 volumio volumio[5149]: info: Discovery: Getting this device information Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:08 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:08 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:08 volumio volumio[5149]: info: Listing playlists Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: Starting Shairport Sync Jun 22 20:55:08 volumio volumio[5149]: info: Starting Shairport Sync Jun 22 20:55:08 volumio volumio[5149]: info: Starting Shairport Sync Jun 22 20:55:08 volumio sudo[5371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:55:08 volumio sudo[5371]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:08 volumio sudo[5374]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:55:08 volumio sudo[5379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:55:08 volumio sudo[5374]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:08 volumio sudo[5379]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:08 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 22 20:55:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 20:55:08 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 20:55:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 20:55:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 20:55:08 volumio sudo[5374]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:08 volumio volumio[5149]: info: Asound.conf file unchanged, so no further update is needed Jun 22 20:55:08 volumio volumio[5149]: info: Output device has changed, restarting MPD Jun 22 20:55:08 volumio sudo[5371]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 20:55:08 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 22 20:55:08 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 20:55:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 20:55:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 20:55:08 volumio sudo[5379]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:08 volumio volumio[5149]: info: Output device has changed, restarting Shairport Sync Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:08 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:08 volumio sudo[5401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 22 20:55:08 volumio sudo[5403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 22 20:55:08 volumio sudo[5401]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:08 volumio sudo[5403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:08 volumio sudo[5401]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:08 volumio volumio[5149]: info: Shairport-Sync Started Jun 22 20:55:08 volumio volumio[5149]: Error adding Membership: Error: addMembership EINVAL Jun 22 20:55:08 volumio volumio[5149]: info: Shairport-Sync Started Jun 22 20:55:08 volumio volumio[5149]: info: Shairport-Sync Started Jun 22 20:55:08 volumio volumio[5149]: info: FusionDsp - Jun 22 20:55:08 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 22 20:55:08 volumio systemd[1]: mpd.service: Succeeded. Jun 22 20:55:08 volumio systemd[1]: Stopped Music Player Daemon. Jun 22 20:55:08 volumio systemd[1]: Starting Music Player Daemon... Jun 22 20:55:08 volumio sudo[5425]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 22 20:55:08 volumio sudo[5425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:08 volumio sudo[5425]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:08 volumio volumio[5149]: info: FusionDsp - Jun 22 20:55:08 volumio volumio[5149]: info: FusionDsp - Jun 22 20:55:09 volumio volumio[5149]: info: MPD Permissions set Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:09 volumio volumio[5149]: info: FusionDsp - Jun 22 20:55:09 volumio volumio[5149]: info: FusionDsp - Jun 22 20:55:09 volumio volumio[5149]: info: FusionDsp - Jun 22 20:55:09 volumio volumio[5149]: info: Starting Shairport Sync Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::volumioGetState Jun 22 20:55:09 volumio volumio[5149]: info: CorePlayQueue::getTrack 0 Jun 22 20:55:09 volumio volumio[5149]: info: CoreCommandRouter::volumioPause Jun 22 20:55:09 volumio volumio[5149]: info: CoreStateMachine::pause Jun 22 20:55:09 volumio volumio[5149]: info: mpdhttpout --- Volumio set on pause Jun 22 20:55:09 volumio volumio[5149]: info: mpdhttpout ---Configuration successfully added to mpd.conf. Jun 22 20:55:09 volumio volumio[5149]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Jun 22 20:55:09 volumio sudo[5445]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 22 20:55:09 volumio sudo[5445]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 22 20:55:09 volumio systemd[1]: shairport-sync.service: Succeeded. Jun 22 20:55:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 22 20:55:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 22 20:55:09 volumio sudo[5445]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:09 volumio volumio[5149]: info: Shairport-Sync Started Jun 22 20:55:09 volumio mpd[5434]: Jun 22 20:55 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 22 20:55:09 volumio systemd[1]: Started Music Player Daemon. Jun 22 20:55:09 volumio sudo[5295]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:09 volumio sudo[5314]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:09 volumio sudo[5403]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:09 volumio volumio[5149]: info: Completed starting Core Plugins Jun 22 20:55:09 volumio volumio[5149]: info: ------------------------------------------- Jun 22 20:55:09 volumio volumio[5149]: info: ----- MyVolumio plugins startup ---- Jun 22 20:55:09 volumio volumio[5149]: info: ------------------------------------------- Jun 22 20:55:09 volumio volumio[5149]: info: [MyVolumio PluginManager] Fetching plans data.... Jun 22 20:55:10 volumio volumio[5149]: error: MPD error: The expression evaluated to a falsy value: Jun 22 20:55:10 volumio volumio[5149]: assert.ok(self.idling) Jun 22 20:55:10 volumio volumio[5149]: error: The expression evaluated to a falsy value: Jun 22 20:55:10 volumio volumio[5149]: assert.ok(self.idling) Jun 22 20:55:10 volumio volumio[5149]: error: MPD error: The expression evaluated to a falsy value: Jun 22 20:55:10 volumio volumio[5149]: assert.ok(self.idling) Jun 22 20:55:10 volumio volumio[5149]: error: The expression evaluated to a falsy value: Jun 22 20:55:10 volumio volumio[5149]: assert.ok(self.idling) Jun 22 20:55:10 volumio volumio[5149]: info: MPD running with PID5434 Jun 22 20:55:10 volumio volumio[5149]: ,establishing connection Jun 22 20:55:10 volumio volumio[5149]: error: updateQueue error: null Jun 22 20:55:10 volumio volumio[5149]: error: updateQueue error: null Jun 22 20:55:10 volumio volumio[5149]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 22 20:55:10 volumio volumio[5149]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Jun 22 20:55:10 volumio volumio[5149]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 22 20:55:10 volumio volumio[5149]: info: camilladsp service started and running in background, instance 1 Jun 22 20:55:10 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 22 20:55:10 volumio volumio[5149]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 22 20:55:10 volumio volumio[5149]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 22 20:55:10 volumio volumio[5149]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 22 20:55:10 volumio volumio[5149]: info: FusionDsp loaded Jun 22 20:55:10 volumio volumio[5149]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 22 20:55:10 volumio sudo[5483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 22 20:55:10 volumio volumio[5149]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 22 20:55:10 volumio volumio[5149]: info: Adding Signal Path Element [object Object] Jun 22 20:55:10 volumio volumio[5149]: info: Adding fusiondspeq DSP Signal Path Element Jun 22 20:55:10 volumio volumio[5149]: info: FusionDsp - ---- installed callbackRead Jun 22 20:55:10 volumio volumio[5149]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 20:55:10 volumio sudo[5483]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 22 20:55:10 volumio volumio[5149]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 22 20:55:10 volumio volumio[5149]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jun 22 20:55:10 volumio volumio[5149]: at onErrorNT (internal/child_process.js:472:16) Jun 22 20:55:10 volumio volumio[5149]: at processTicksAndRejections (internal/process/task_queues.js:82:21) { Jun 22 20:55:10 volumio volumio[5149]: errno: -2, Jun 22 20:55:10 volumio volumio[5149]: code: 'ENOENT', Jun 22 20:55:10 volumio volumio[5149]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 22 20:55:10 volumio volumio[5149]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 22 20:55:10 volumio volumio[5149]: spawnargs: [ Jun 22 20:55:10 volumio volumio[5149]: '-p', Jun 22 20:55:10 volumio volumio[5149]: 9876, Jun 22 20:55:10 volumio volumio[5149]: '-o', Jun 22 20:55:10 volumio volumio[5149]: '/tmp/camilladsp.log', Jun 22 20:55:10 volumio volumio[5149]: '-l', Jun 22 20:55:10 volumio volumio[5149]: 'warn', Jun 22 20:55:10 volumio volumio[5149]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 22 20:55:10 volumio volumio[5149]: ] Jun 22 20:55:10 volumio volumio[5149]: } Jun 22 20:55:10 volumio volumio[5149]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 22 20:55:10 volumio systemd[1]: Started FusionDsp Daemon. Jun 22 20:55:10 volumio sudo[5483]: pam_unix(sudo:session): session closed for user root Jun 22 20:55:10 volumio sudo[5502]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-22 20:54 Jun 22 20:55:10 volumio sudo[5502]: 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="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="armv7" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 05:12:56 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="tinkerboard" VOLUMIO_DEVICENAME="Asus Tinkerboard" VOLUMIO_HASH="f5ff903d28fee878b80ffec17b533674"