-- Logs begin at Sun 2025-06-29 11:54:06 BST, end at Mon 2025-06-30 11:45:58 BST. -- Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "network"... Jun 30 11:44:00 simonpi volumio[23001]: info: Refreshing Cached IP Addresses Jun 30 11:44:00 simonpi sudo[23029]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:44:00 simonpi sudo[23029]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:00 simonpi sudo[23031]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:44:00 simonpi sudo[23031]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:00 simonpi sudo[23031]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "services"... Jun 30 11:44:00 simonpi sudo[23029]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "alsa_controller"... Jun 30 11:44:00 simonpi sudo[23043]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:44:00 simonpi sudo[23043]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:00 simonpi volumio[23001]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device. Jun 30 11:44:00 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "wizard"... Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "networkfs"... Jun 30 11:44:00 simonpi volumio[23001]: info: Starting Udev Watcher for removable devices Jun 30 11:44:00 simonpi volumio[23001]: info: Ignoring mount for partition: boot Jun 30 11:44:00 simonpi volumio[23001]: info: Ignoring mount for partition: volumio Jun 30 11:44:00 simonpi volumio[23001]: info: Ignoring mount for partition: volumio_data Jun 30 11:44:00 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "upnp"... Jun 30 11:44:00 simonpi volumio[23001]: info: [1751280240789] Starting Upmpd Daemon Jun 30 11:44:00 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "my_music"... Jun 30 11:44:00 simonpi volumio[23001]: info: Loading plugin "mpd"... Jun 30 11:44:00 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:00] [connect] Successful connection Jun 30 11:44:01 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:01 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 296. Jun 30 11:44:01 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:01 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:01 simonpi volumio[23001]: info: Plugin upnp_browser is not enabled Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "alarm-clock"... Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "airplay_emulation"... Jun 30 11:44:01 simonpi volumio[23001]: info: Starting Shairport Sync Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "last_100"... Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "webradio"... Jun 30 11:44:01 simonpi sudo[23043]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "i2s_dacs"... Jun 30 11:44:01 simonpi volumio[23001]: info: I2S DAC not set, start Auto-detection Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "volumiodiscovery"... Jun 30 11:44:01 simonpi volumio[23001]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:01 simonpi volumio[23001]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:01 simonpi volumio[23001]: *** WARNING *** For more information see Jun 30 11:44:01 simonpi volumio[23001]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:01 simonpi volumio[23001]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:01 simonpi node[23001]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:01 simonpi volumio[23001]: *** WARNING *** For more information see Jun 30 11:44:01 simonpi node[23001]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:01 simonpi node[23001]: *** WARNING *** For more information see Jun 30 11:44:01 simonpi node[23001]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:01 simonpi node[23001]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:01 simonpi node[23001]: *** WARNING *** For more information see Jun 30 11:44:01 simonpi volumio[23001]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:44:01 simonpi volumio[23001]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:44:01 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "outputs"... Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "albumart"... Jun 30 11:44:01 simonpi volumio[23001]: info: Plugin example_plugin is not enabled Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "inputs"... Jun 30 11:44:01 simonpi volumio[23001]: info: Loading plugin "updater_comm"... Jun 30 11:44:02 simonpi volumio[23001]: info: Plugin mpdemulation is not enabled Jun 30 11:44:02 simonpi volumio[23001]: info: Loading plugin "rest_api"... Jun 30 11:44:02 simonpi volumio[23001]: info: Loading plugin "websocket"... Jun 30 11:44:02 simonpi volumio[23001]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:44:02 simonpi volumio[23001]: info: Loading plugin "fusiondsp"... Jun 30 11:44:02 simonpi volumio[23001]: Forking 3 albumart workers Jun 30 11:44:02 simonpi volumio[23001]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:44:02 simonpi volumio[23001]: info: Loading i18n strings for locale en Jun 30 11:44:02 simonpi volumio[23001]: Updating browse sources language Jun 30 11:44:02 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:02 simonpi volumio[23056]: Traceback (most recent call last): Jun 30 11:44:02 simonpi volumio[23056]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:02 simonpi volumio[23056]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:02 simonpi volumio[23056]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:03 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:03 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::initPlayerControls Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: Express server listening on port 3000 Jun 30 11:44:03 simonpi volumio[23001]: [Metrics] WebUI: 5s 680.96ms Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::resetVolumioState Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::getcurrentVolume Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:03 simonpi volumio[23001]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:44:03 simonpi volumio[23001]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:44:03 simonpi volumio[23001]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 30 11:44:03 simonpi volumio[23001]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Jun 30 11:44:03 simonpi volumio[23001]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jun 30 11:44:03 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280240 101 Jun 30 11:44:03 simonpi volumio[23001]: 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: 4 Jun 30 11:44:03 simonpi volumio[23001]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::pushState Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::updateTrackBlock Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrackBlock Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:44:03 simonpi volumio[23001]: info: Discovery: Getting this device information Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:03 simonpi volumio[23001]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 30 11:44:03 simonpi volumio[23001]: info: Reloading queue from file Jun 30 11:44:03 simonpi volumio[23001]: Starting albumart workers Jun 30 11:44:03 simonpi volumio[23001]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:44:03 simonpi volumio[23001]: Starting albumart workers Jun 30 11:44:03 simonpi volumio[23001]: info: Setting Device type: Raspberry PI Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::pushState Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::setRandom null Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::pushState Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:03 simonpi volumio[23001]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:44:03 simonpi volumio[23001]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:44:03 simonpi volumio[23001]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:44:03 simonpi volumio[23001]: Starting albumart workers Jun 30 11:44:03 simonpi volumio[23001]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Jun 30 11:44:03 simonpi volumio[23001]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:44:03 simonpi volumio[23001]: info: CoreStateMachine::pushState Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:03 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:44:03 simonpi volumio[23001]: info: Received Get System Info Jun 30 11:44:03 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:44:04 simonpi volumio[23001]: info: Discovery: Getting this device information Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:04 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:04 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:04 simonpi volumio[23001]: info: Listing playlists Jun 30 11:44:04 simonpi volumio[23001]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:44:04 simonpi volumio[23001]: info: Discovery: Found device SimonPi Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:04 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:04 simonpi volumio[23001]: info: Completed loading Core Plugins Jun 30 11:44:04 simonpi volumio[23001]: info: Preparing to generate the ALSA configuration file Jun 30 11:44:04 simonpi volumio[23001]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:44:04 simonpi volumio[23001]: info: Reading ALSA contributions from plugins. Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:04 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:05 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:05 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:05 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 297. Jun 30 11:44:05 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:05 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:05 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:05 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:05 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:06 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:06 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:06 simonpi volumio[23123]: Traceback (most recent call last): Jun 30 11:44:06 simonpi volumio[23123]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:06 simonpi volumio[23123]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:06 simonpi volumio[23123]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:06 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:06 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:06 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:07 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:07 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:07 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:08 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:08 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:08 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:08 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:08 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:09 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:09 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 298. Jun 30 11:44:09 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:09 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:09 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:09 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:09 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:10 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:10 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:10 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:10 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:10 simonpi volumio[23124]: Traceback (most recent call last): Jun 30 11:44:10 simonpi volumio[23124]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:10 simonpi volumio[23124]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:10 simonpi volumio[23124]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:10 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:10 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:10 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:11 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:11 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:11 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:11 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:12 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:12 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:12 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:12 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:13 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:13 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:13 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 299. Jun 30 11:44:13 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:13 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:13 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:13 simonpi volumio[23001]: info: FusionDsp - Jun 30 11:44:13 simonpi sudo[23144]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:44:13 simonpi sudo[23144]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:13 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:13 simonpi sudo[23147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:44:13 simonpi sudo[23147]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:13 simonpi sudo[23147]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:13 simonpi sudo[23144]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:13 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23142]: Traceback (most recent call last): Jun 30 11:44:14 simonpi volumio[23142]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:14 simonpi volumio[23142]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:14 simonpi volumio[23142]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:14 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:14 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:14 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:15 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:16 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:16 simonpi volumio[23001]: info: FusionDsp - undefined Jun 30 11:44:16 simonpi volumio[23001]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:44:16 simonpi volumio[23001]: info: Output device has changed, restarting MPD Jun 30 11:44:16 simonpi sudo[23152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:16 simonpi sudo[23152]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:16 simonpi volumio[23001]: info: Output device has changed, restarting Shairport Sync Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:16 simonpi sudo[23152]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:16 simonpi sudo[23155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:16 simonpi sudo[23155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:16 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:44:16 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:16 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:16 simonpi volumio[23001]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:16 simonpi volumio[23001]: info: ___________ START PLUGINS ___________ Jun 30 11:44:16 simonpi volumio[23001]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:44:16 simonpi volumio[23001]: info: Creating MPD Configuration file Jun 30 11:44:16 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:16 simonpi sudo[23162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:16 simonpi sudo[23162]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:16 simonpi sudo[23162]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:16 simonpi sudo[23165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:16 simonpi sudo[23165]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:16 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:44:16 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:16 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:16 simonpi volumio[23001]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:16 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:16 simonpi volumio[23001]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:44:16 simonpi volumio[23001]: info: [1751280256582] CoreMusicLibrary::Adding element Last_100 Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:44:16 simonpi volumio[23001]: info: [1751280256597] CoreMusicLibrary::Adding element Webradio Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:16 simonpi volumio[23001]: info: Initializing BBC Radios Jun 30 11:44:16 simonpi volumio[23001]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:16 simonpi sudo[23170]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:44:16 simonpi sudo[23170]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:16 simonpi sudo[23170]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:16 simonpi volumio[23001]: info: Loading i18n strings for locale en Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:44:16 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:16 simonpi volumio[23001]: info: FusionDsp - mixtype--------------------- undefined Jun 30 11:44:16 simonpi volumio[23001]: info: Volumio Calling Home Jun 30 11:44:16 simonpi volumio[23001]: info: Preparing to generate the ALSA configuration file Jun 30 11:44:17 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:17 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 300. Jun 30 11:44:17 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:44:17 simonpi volumio[23001]: info: Discovery: Getting this device information Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:17 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:17 simonpi volumio[23001]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:44:17 simonpi volumio[23001]: info: Reading ALSA contributions from plugins. Jun 30 11:44:17 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:17 simonpi volumio[23001]: info: MPD Permissions set Jun 30 11:44:17 simonpi sudo[23191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jun 30 11:44:17 simonpi sudo[23191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:17 simonpi volumio[23001]: 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 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi sudo[23191]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:17 simonpi volumio[23001]: info: Volumio called home Jun 30 11:44:18 simonpi volumio[23001]: info: Upmpdcli Daemon Started Jun 30 11:44:18 simonpi volumio[23001]: info: Starting Shairport Sync Jun 30 11:44:18 simonpi volumio[23001]: info: Starting Shairport Sync Jun 30 11:44:18 simonpi sudo[23202]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:44:18 simonpi volumio[23001]: info: Starting Shairport Sync Jun 30 11:44:18 simonpi sudo[23202]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:18 simonpi sudo[23204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:44:18 simonpi sudo[23204]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:18 simonpi sudo[23208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:44:18 simonpi sudo[23208]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:18 simonpi volumio[23001]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:18 simonpi volumio[23001]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:18 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:44:18 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:44:18 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:18 simonpi volumio[23001]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:44:18 simonpi volumio[23001]: info: Output device has changed, restarting MPD Jun 30 11:44:18 simonpi volumio[23001]: info: Output device has changed, restarting Shairport Sync Jun 30 11:44:18 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:18 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:18 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:18 simonpi sudo[23204]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:18 simonpi sudo[23212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:18 simonpi sudo[23208]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:18 simonpi sudo[23212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:18 simonpi sudo[23202]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:18 simonpi sudo[23214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:18 simonpi sudo[23214]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:18 simonpi sudo[23212]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:18 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:44:18 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:18 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:18 simonpi volumio[23001]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:18 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:18 simonpi volumio[23001]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:44:18 simonpi volumio[23001]: 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 30 11:44:18 simonpi volumio[23001]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:44:19 simonpi volumio[23001]: info: camilladsp service started and running in background, instance 1 Jun 30 11:44:19 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:19 simonpi volumio[23001]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:44:19 simonpi volumio[23001]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 30 11:44:19 simonpi volumio[23001]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:44:19 simonpi volumio[23001]: info: FusionDsp loaded Jun 30 11:44:19 simonpi volumio[23001]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:19 simonpi sudo[23233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:44:19 simonpi sudo[23233]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:19 simonpi sudo[23222]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:44:19 simonpi sudo[23222]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:19 simonpi volumio[23001]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:44:19 simonpi volumio[23001]: info: Adding Signal Path Element [object Object] Jun 30 11:44:19 simonpi volumio[23001]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:44:19 simonpi sudo[23222]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:19 simonpi volumio[23001]: info: FusionDsp - ---- installed callbackRead Jun 30 11:44:19 simonpi volumio[23001]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:44:19 simonpi volumio[23189]: Traceback (most recent call last): Jun 30 11:44:19 simonpi volumio[23189]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:19 simonpi volumio[23189]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:19 simonpi volumio[23189]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:19 simonpi sudo[23233]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:19 simonpi volumio[23001]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:44:19 simonpi volumio[23001]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:44:19 simonpi volumio[23001]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:44:19 simonpi volumio[23001]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 30 11:44:19 simonpi volumio[23001]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 30 11:44:19 simonpi volumio[23001]: at listOnTimeout (internal/timers.js:523:9) Jun 30 11:44:19 simonpi volumio[23001]: at processTimers (internal/timers.js:497:7) { Jun 30 11:44:19 simonpi volumio[23001]: errno: -2, Jun 30 11:44:19 simonpi volumio[23001]: code: 'ENOENT', Jun 30 11:44:19 simonpi volumio[23001]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:44:19 simonpi volumio[23001]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:44:19 simonpi volumio[23001]: spawnargs: [ Jun 30 11:44:19 simonpi volumio[23001]: '-p', Jun 30 11:44:19 simonpi volumio[23001]: 9876, Jun 30 11:44:19 simonpi volumio[23001]: '-o', Jun 30 11:44:19 simonpi volumio[23001]: '/tmp/camilladsp.log', Jun 30 11:44:19 simonpi volumio[23001]: '-l', Jun 30 11:44:19 simonpi volumio[23001]: 'warn', Jun 30 11:44:19 simonpi volumio[23001]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:44:19 simonpi volumio[23001]: ] Jun 30 11:44:19 simonpi volumio[23001]: } Jun 30 11:44:19 simonpi volumio[23001]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:44:19 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:19 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:19 simonpi sudo[23246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:43 Jun 30 11:44:19 simonpi sudo[23246]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:20 simonpi sudo[23246]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:20 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:20] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:44:20 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:20] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:44:20 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:20 simonpi sudo[23165]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:20 simonpi sudo[23155]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:20 simonpi sudo[23214]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:20 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:44:20 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:44:20 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:44:20 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:44:20 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 88. Jun 30 11:44:20 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:44:20 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:44:20 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:44:20 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:44:20 simonpi mpd[23236]: Jun 30 11:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:44:20 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:44:21 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:21 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 301. Jun 30 11:44:21 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:21 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:22 simonpi volumio[23256]: info: ------------------------------------------- Jun 30 11:44:22 simonpi volumio[23256]: info: ----- Volumio3 ---- Jun 30 11:44:22 simonpi volumio[23256]: info: ------------------------------------------- Jun 30 11:44:22 simonpi volumio[23256]: info: ----- System startup ---- Jun 30 11:44:22 simonpi volumio[23256]: info: ------------------------------------------- Jun 30 11:44:23 simonpi volumio[23271]: Traceback (most recent call last): Jun 30 11:44:23 simonpi volumio[23271]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:23 simonpi volumio[23271]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:23 simonpi volumio[23271]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:23 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:23 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:23 simonpi volumio[23256]: info: MYVOLUMIO Environment detected Jun 30 11:44:23 simonpi volumio[23256]: info: Plugin folders cleanup Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning category audio_interface Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning category miscellanea Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning category music_service Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning category plugins.json Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning category system_controller Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning category user_interface Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning into folder /data/plugins/ Jun 30 11:44:23 simonpi volumio[23256]: info: Scanning category audio_interface Jun 30 11:44:23 simonpi volumio[23256]: info: Plugin folders cleanup completed Jun 30 11:44:23 simonpi volumio[23256]: info: ------------------------------------------- Jun 30 11:44:23 simonpi volumio[23256]: info: ----- Core plugins startup ---- Jun 30 11:44:23 simonpi volumio[23256]: info: ------------------------------------------- Jun 30 11:44:23 simonpi volumio[23256]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:44:23 simonpi volumio[23256]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:44:23 simonpi volumio[23256]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:44:23 simonpi volumio[23256]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:44:23 simonpi volumio[23256]: info: Loading plugins from folder /data/plugins/ Jun 30 11:44:23 simonpi volumio[23256]: info: Loading plugin "system"... Jun 30 11:44:23 simonpi volumio[23256]: info: Loading plugin "appearance"... Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "network"... Jun 30 11:44:25 simonpi volumio[23256]: info: Refreshing Cached IP Addresses Jun 30 11:44:25 simonpi sudo[23325]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:44:25 simonpi sudo[23325]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:25 simonpi sudo[23327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:44:25 simonpi sudo[23327]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:25 simonpi sudo[23327]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:25 simonpi sudo[23325]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "services"... Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "alsa_controller"... Jun 30 11:44:25 simonpi sudo[23338]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:44:25 simonpi sudo[23338]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:25 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:25] [connect] Successful connection Jun 30 11:44:25 simonpi volumio[23256]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device. Jun 30 11:44:25 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "wizard"... Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "networkfs"... Jun 30 11:44:25 simonpi volumio[23256]: info: Starting Udev Watcher for removable devices Jun 30 11:44:25 simonpi volumio[23256]: info: Ignoring mount for partition: boot Jun 30 11:44:25 simonpi volumio[23256]: info: Ignoring mount for partition: volumio Jun 30 11:44:25 simonpi volumio[23256]: info: Ignoring mount for partition: volumio_data Jun 30 11:44:25 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "upnp"... Jun 30 11:44:25 simonpi volumio[23256]: info: [1751280265372] Starting Upmpd Daemon Jun 30 11:44:25 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "my_music"... Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "mpd"... Jun 30 11:44:25 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:25 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 302. Jun 30 11:44:25 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:25 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:25 simonpi volumio[23256]: info: Plugin upnp_browser is not enabled Jun 30 11:44:25 simonpi volumio[23256]: info: Loading plugin "alarm-clock"... Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "airplay_emulation"... Jun 30 11:44:26 simonpi volumio[23256]: info: Starting Shairport Sync Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "last_100"... Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "webradio"... Jun 30 11:44:26 simonpi sudo[23338]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "i2s_dacs"... Jun 30 11:44:26 simonpi volumio[23256]: info: I2S DAC not set, start Auto-detection Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "volumiodiscovery"... Jun 30 11:44:26 simonpi volumio[23256]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:26 simonpi volumio[23256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:26 simonpi volumio[23256]: *** WARNING *** For more information see Jun 30 11:44:26 simonpi node[23256]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:26 simonpi volumio[23256]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:26 simonpi volumio[23256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:26 simonpi volumio[23256]: *** WARNING *** For more information see Jun 30 11:44:26 simonpi node[23256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:26 simonpi node[23256]: *** WARNING *** For more information see Jun 30 11:44:26 simonpi node[23256]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:26 simonpi node[23256]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:26 simonpi node[23256]: *** WARNING *** For more information see Jun 30 11:44:26 simonpi volumio[23256]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:44:26 simonpi volumio[23256]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:44:26 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "outputs"... Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "albumart"... Jun 30 11:44:26 simonpi volumio[23256]: info: Plugin example_plugin is not enabled Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "inputs"... Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "updater_comm"... Jun 30 11:44:26 simonpi volumio[23256]: info: Plugin mpdemulation is not enabled Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "rest_api"... Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "websocket"... Jun 30 11:44:26 simonpi volumio[23256]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:44:26 simonpi volumio[23256]: info: Loading plugin "fusiondsp"... Jun 30 11:44:26 simonpi volumio[23256]: Forking 3 albumart workers Jun 30 11:44:27 simonpi volumio[23256]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:44:27 simonpi volumio[23352]: Traceback (most recent call last): Jun 30 11:44:27 simonpi volumio[23352]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:27 simonpi volumio[23352]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:27 simonpi volumio[23352]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:27 simonpi volumio[23256]: info: Loading i18n strings for locale en Jun 30 11:44:27 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:27 simonpi volumio[23256]: Updating browse sources language Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:27 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::initPlayerControls Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: Express server listening on port 3000 Jun 30 11:44:27 simonpi volumio[23256]: [Metrics] WebUI: 5s 748.89ms Jun 30 11:44:27 simonpi volumio[23256]: info: CoreStateMachine::resetVolumioState Jun 30 11:44:27 simonpi volumio[23256]: info: CoreStateMachine::getcurrentVolume Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:44:27 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:27 simonpi volumio[23256]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:44:28 simonpi volumio[23256]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:44:28 simonpi volumio[23256]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Jun 30 11:44:28 simonpi volumio[23256]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jun 30 11:44:28 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280265 101 Jun 30 11:44:28 simonpi volumio[23256]: 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: 3 Jun 30 11:44:28 simonpi volumio[23256]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:44:28 simonpi volumio[23256]: info: CoreStateMachine::pushState Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:28 simonpi volumio[23256]: info: CoreStateMachine::updateTrackBlock Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrackBlock Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:44:28 simonpi volumio[23256]: Starting albumart workers Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:44:28 simonpi volumio[23256]: info: Discovery: Getting this device information Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:28 simonpi volumio[23256]: Starting albumart workers Jun 30 11:44:28 simonpi volumio[23256]: info: Reloading queue from file Jun 30 11:44:28 simonpi volumio[23256]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:44:28 simonpi volumio[23256]: info: Setting Device type: Raspberry PI Jun 30 11:44:28 simonpi volumio[23256]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:44:28 simonpi volumio[23256]: info: CoreStateMachine::pushState Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:28 simonpi volumio[23256]: info: CoreStateMachine::setRandom null Jun 30 11:44:28 simonpi volumio[23256]: info: CoreStateMachine::pushState Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:28 simonpi volumio[23256]: Starting albumart workers Jun 30 11:44:28 simonpi volumio[23256]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:44:28 simonpi volumio[23256]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:44:28 simonpi volumio[23256]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:44:28 simonpi volumio[23256]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:44:28 simonpi volumio[23256]: info: CoreStateMachine::pushState Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:28 simonpi volumio[23256]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:44:28 simonpi volumio[23256]: info: Completed loading Core Plugins Jun 30 11:44:28 simonpi volumio[23256]: info: Preparing to generate the ALSA configuration file Jun 30 11:44:28 simonpi volumio[23256]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:44:28 simonpi volumio[23256]: info: Discovery: Found device SimonPi Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:28 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:28 simonpi volumio[23256]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:44:28 simonpi volumio[23256]: info: Reading ALSA contributions from plugins. Jun 30 11:44:28 simonpi volumio[23256]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:44:28 simonpi volumio[23256]: info: Output device has changed, restarting MPD Jun 30 11:44:28 simonpi volumio[23256]: info: Output device has changed, restarting Shairport Sync Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:28 simonpi sudo[23396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:28 simonpi sudo[23396]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:28 simonpi sudo[23398]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:28 simonpi sudo[23398]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:28 simonpi sudo[23396]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:28 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:44:28 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:28 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:28 simonpi volumio[23256]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:28 simonpi volumio[23256]: info: ___________ START PLUGINS ___________ Jun 30 11:44:28 simonpi volumio[23256]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:44:28 simonpi volumio[23256]: info: Creating MPD Configuration file Jun 30 11:44:28 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:28 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:28 simonpi sudo[23406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:28 simonpi sudo[23406]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:28 simonpi sudo[23406]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:28 simonpi sudo[23410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:28 simonpi sudo[23410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:28 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:44:28 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:28 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:29 simonpi volumio[23256]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:29 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:29 simonpi volumio[23256]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:44:29 simonpi volumio[23256]: info: [1751280269133] CoreMusicLibrary::Adding element Last_100 Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:44:29 simonpi volumio[23256]: info: [1751280269145] CoreMusicLibrary::Adding element Webradio Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:29 simonpi volumio[23256]: info: Initializing BBC Radios Jun 30 11:44:29 simonpi volumio[23256]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:29 simonpi sudo[23415]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:44:29 simonpi sudo[23415]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:29 simonpi sudo[23415]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: Loading i18n strings for locale en Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: FusionDsp - mixtype--------------------- undefined Jun 30 11:44:29 simonpi volumio[23256]: info: Volumio Calling Home Jun 30 11:44:29 simonpi volumio[23256]: info: Preparing to generate the ALSA configuration file Jun 30 11:44:29 simonpi volumio[23256]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:44:29 simonpi volumio[23256]: info: Reading ALSA contributions from plugins. Jun 30 11:44:29 simonpi volumio[23256]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 30 11:44:29 simonpi volumio[23256]: info: MPD Permissions set Jun 30 11:44:29 simonpi volumio[23256]: info: MPD Permissions set Jun 30 11:44:29 simonpi volumio[23256]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 30 11:44:29 simonpi volumio[23256]: info: Volumio called home Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:29 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:29 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:29 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 303. Jun 30 11:44:29 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:29 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:29 simonpi volumio[23256]: info: Starting Shairport Sync Jun 30 11:44:29 simonpi volumio[23256]: info: Starting Shairport Sync Jun 30 11:44:29 simonpi volumio[23256]: info: Starting Shairport Sync Jun 30 11:44:29 simonpi sudo[23470]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:44:29 simonpi sudo[23470]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:30 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:44:30 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:44:30 simonpi sudo[23472]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:44:30 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi sudo[23472]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:30 simonpi sudo[23475]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:44:30 simonpi sudo[23475]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:30 simonpi volumio[23256]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:30 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi sudo[23470]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:30 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:44:30 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 30 11:44:30 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:44:30 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi sudo[23472]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:30 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:44:30 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 30 11:44:30 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:44:30 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi sudo[23475]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:30 simonpi volumio[23256]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:44:30 simonpi volumio[23256]: info: Output device has changed, restarting MPD Jun 30 11:44:30 simonpi volumio[23256]: info: Output device has changed, restarting Shairport Sync Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:30 simonpi sudo[23482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:30 simonpi sudo[23482]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:30 simonpi sudo[23482]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:30 simonpi sudo[23484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:30 simonpi sudo[23484]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:30 simonpi volumio[23256]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:30 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:44:30 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:30 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:30 simonpi volumio[23256]: info: Shairport-Sync Started Jun 30 11:44:30 simonpi volumio[23256]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:44:30 simonpi volumio[23256]: info: Shairport-Sync Started Jun 30 11:44:30 simonpi volumio[23256]: info: MPD Permissions set Jun 30 11:44:30 simonpi volumio[23256]: info: Shairport-Sync Started Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:30 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:30 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:30 simonpi volumio[23256]: info: Starting Shairport Sync Jun 30 11:44:30 simonpi sudo[23499]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:44:30 simonpi sudo[23499]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:30 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:44:30 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:44:30 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi sudo[23492]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:44:30 simonpi sudo[23492]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:30 simonpi sudo[23492]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:30 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:44:30 simonpi sudo[23499]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:30 simonpi volumio[23256]: info: Shairport-Sync Started Jun 30 11:44:31 simonpi volumio[23256]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:44:31 simonpi volumio[23256]: 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 30 11:44:31 simonpi volumio[23256]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:44:31 simonpi volumio[23256]: info: camilladsp service started and running in background, instance 1 Jun 30 11:44:31 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:31 simonpi volumio[23256]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:44:31 simonpi volumio[23256]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 30 11:44:31 simonpi volumio[23256]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:44:31 simonpi volumio[23256]: info: FusionDsp loaded Jun 30 11:44:31 simonpi volumio[23256]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:31 simonpi sudo[23516]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:44:31 simonpi sudo[23516]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:31 simonpi volumio[23256]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:44:31 simonpi volumio[23256]: info: Adding Signal Path Element [object Object] Jun 30 11:44:31 simonpi volumio[23256]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:44:31 simonpi volumio[23256]: info: FusionDsp - ---- installed callbackRead Jun 30 11:44:31 simonpi volumio[23256]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:44:31 simonpi sudo[23516]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:31 simonpi volumio[23256]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:44:31 simonpi volumio[23256]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:44:31 simonpi volumio[23256]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:44:31 simonpi volumio[23256]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jun 30 11:44:31 simonpi volumio[23256]: errno: -2, Jun 30 11:44:31 simonpi volumio[23256]: code: 'ENOENT', Jun 30 11:44:31 simonpi volumio[23256]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:44:31 simonpi volumio[23256]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:44:31 simonpi volumio[23256]: spawnargs: [ Jun 30 11:44:31 simonpi volumio[23256]: '-p', Jun 30 11:44:31 simonpi volumio[23256]: 9876, Jun 30 11:44:31 simonpi volumio[23256]: '-o', Jun 30 11:44:31 simonpi volumio[23256]: '/tmp/camilladsp.log', Jun 30 11:44:31 simonpi volumio[23256]: '-l', Jun 30 11:44:31 simonpi volumio[23256]: 'warn', Jun 30 11:44:31 simonpi volumio[23256]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:44:31 simonpi volumio[23256]: ] Jun 30 11:44:31 simonpi volumio[23256]: } Jun 30 11:44:31 simonpi volumio[23256]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:44:31 simonpi volumio[23468]: Traceback (most recent call last): Jun 30 11:44:31 simonpi volumio[23468]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:31 simonpi volumio[23468]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:31 simonpi volumio[23468]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:31 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:31 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:32 simonpi sudo[23527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:43 Jun 30 11:44:32 simonpi sudo[23527]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:32 simonpi sudo[23527]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:32 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:32] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:44:32 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:32] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:44:32 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:32 simonpi sudo[23398]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:32 simonpi sudo[23410]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:32 simonpi sudo[23484]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:32 simonpi mpd[23503]: Jun 30 11:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:44:32 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:44:32 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:44:32 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:44:32 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:44:32 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:44:32 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 89. Jun 30 11:44:32 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:44:32 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:44:32 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:44:32 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:44:34 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:34 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 304. Jun 30 11:44:34 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:34 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:35 simonpi volumio[23541]: info: ------------------------------------------- Jun 30 11:44:35 simonpi volumio[23541]: info: ----- Volumio3 ---- Jun 30 11:44:35 simonpi volumio[23541]: info: ------------------------------------------- Jun 30 11:44:35 simonpi volumio[23541]: info: ----- System startup ---- Jun 30 11:44:35 simonpi volumio[23541]: info: ------------------------------------------- Jun 30 11:44:35 simonpi volumio[23553]: Traceback (most recent call last): Jun 30 11:44:35 simonpi volumio[23553]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:35 simonpi volumio[23553]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:35 simonpi volumio[23553]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:35 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:35 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:35 simonpi volumio[23541]: info: MYVOLUMIO Environment detected Jun 30 11:44:36 simonpi volumio[23541]: info: Plugin folders cleanup Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning category audio_interface Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning category miscellanea Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning category music_service Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning category plugins.json Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning category system_controller Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning category user_interface Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning into folder /data/plugins/ Jun 30 11:44:36 simonpi volumio[23541]: info: Scanning category audio_interface Jun 30 11:44:36 simonpi volumio[23541]: info: Plugin folders cleanup completed Jun 30 11:44:36 simonpi volumio[23541]: info: ------------------------------------------- Jun 30 11:44:36 simonpi volumio[23541]: info: ----- Core plugins startup ---- Jun 30 11:44:36 simonpi volumio[23541]: info: ------------------------------------------- Jun 30 11:44:36 simonpi volumio[23541]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:44:36 simonpi volumio[23541]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:44:36 simonpi volumio[23541]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:44:36 simonpi volumio[23541]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:44:36 simonpi volumio[23541]: info: Loading plugins from folder /data/plugins/ Jun 30 11:44:36 simonpi volumio[23541]: info: Loading plugin "system"... Jun 30 11:44:36 simonpi volumio[23541]: info: Loading plugin "appearance"... Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "network"... Jun 30 11:44:37 simonpi volumio[23541]: info: Refreshing Cached IP Addresses Jun 30 11:44:37 simonpi sudo[23568]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:44:37 simonpi sudo[23568]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:37 simonpi sudo[23570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:44:37 simonpi sudo[23570]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:37 simonpi sudo[23570]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:37 simonpi sudo[23568]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "services"... Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "alsa_controller"... Jun 30 11:44:37 simonpi sudo[23585]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:44:37 simonpi sudo[23585]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:37 simonpi volumio[23541]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device. Jun 30 11:44:37 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "wizard"... Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "networkfs"... Jun 30 11:44:37 simonpi volumio[23541]: info: Starting Udev Watcher for removable devices Jun 30 11:44:37 simonpi volumio[23541]: info: Ignoring mount for partition: boot Jun 30 11:44:37 simonpi volumio[23541]: info: Ignoring mount for partition: volumio Jun 30 11:44:37 simonpi volumio[23541]: info: Ignoring mount for partition: volumio_data Jun 30 11:44:37 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:44:37 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:37] [connect] Successful connection Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "upnp"... Jun 30 11:44:37 simonpi volumio[23541]: info: [1751280277574] Starting Upmpd Daemon Jun 30 11:44:37 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "my_music"... Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "mpd"... Jun 30 11:44:37 simonpi volumio[23541]: info: Plugin upnp_browser is not enabled Jun 30 11:44:37 simonpi volumio[23541]: info: Loading plugin "alarm-clock"... Jun 30 11:44:38 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:38 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 305. Jun 30 11:44:38 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:38 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "airplay_emulation"... Jun 30 11:44:38 simonpi volumio[23541]: info: Starting Shairport Sync Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "last_100"... Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "webradio"... Jun 30 11:44:38 simonpi sudo[23585]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "i2s_dacs"... Jun 30 11:44:38 simonpi volumio[23541]: info: I2S DAC not set, start Auto-detection Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "volumiodiscovery"... Jun 30 11:44:38 simonpi volumio[23541]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:38 simonpi volumio[23541]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:38 simonpi volumio[23541]: *** WARNING *** For more information see Jun 30 11:44:38 simonpi node[23541]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:38 simonpi volumio[23541]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:38 simonpi volumio[23541]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:38 simonpi volumio[23541]: *** WARNING *** For more information see Jun 30 11:44:38 simonpi node[23541]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:38 simonpi node[23541]: *** WARNING *** For more information see Jun 30 11:44:38 simonpi node[23541]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:38 simonpi node[23541]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:38 simonpi node[23541]: *** WARNING *** For more information see Jun 30 11:44:38 simonpi volumio[23541]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:44:38 simonpi volumio[23541]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:44:38 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "outputs"... Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "albumart"... Jun 30 11:44:38 simonpi volumio[23541]: info: Plugin example_plugin is not enabled Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "inputs"... Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "updater_comm"... Jun 30 11:44:38 simonpi volumio[23541]: info: Plugin mpdemulation is not enabled Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "rest_api"... Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "websocket"... Jun 30 11:44:38 simonpi volumio[23541]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:44:38 simonpi volumio[23541]: info: Loading plugin "fusiondsp"... Jun 30 11:44:39 simonpi volumio[23541]: Forking 3 albumart workers Jun 30 11:44:39 simonpi volumio[23541]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:44:39 simonpi volumio[23541]: info: Loading i18n strings for locale en Jun 30 11:44:39 simonpi volumio[23541]: Updating browse sources language Jun 30 11:44:39 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:39 simonpi volumio[23595]: Traceback (most recent call last): Jun 30 11:44:39 simonpi volumio[23595]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:39 simonpi volumio[23595]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:39 simonpi volumio[23595]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::initPlayerControls Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: Express server listening on port 3000 Jun 30 11:44:40 simonpi volumio[23541]: [Metrics] WebUI: 5s 804.95ms Jun 30 11:44:40 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:40 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::resetVolumioState Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::getcurrentVolume Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:40 simonpi volumio[23541]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:44:40 simonpi volumio[23541]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:44:40 simonpi volumio[23541]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 30 11:44:40 simonpi volumio[23541]: Starting albumart workers Jun 30 11:44:40 simonpi volumio[23541]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Jun 30 11:44:40 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280277 101 Jun 30 11:44:40 simonpi volumio[23541]: 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: 3 Jun 30 11:44:40 simonpi volumio[23541]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::pushState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::updateTrackBlock Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrackBlock Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:44:40 simonpi volumio[23541]: info: Discovery: Getting this device information Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:40 simonpi volumio[23541]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 30 11:44:40 simonpi volumio[23541]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:44:40 simonpi volumio[23541]: info: Reloading queue from file Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::pushState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::setRandom null Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::pushState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:40 simonpi volumio[23541]: info: Setting Device type: Raspberry PI Jun 30 11:44:40 simonpi volumio[23541]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:44:40 simonpi volumio[23541]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:44:40 simonpi volumio[23541]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:44:40 simonpi volumio[23541]: Starting albumart workers Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:44:40 simonpi volumio[23541]: Starting albumart workers Jun 30 11:44:40 simonpi volumio[23541]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:44:40 simonpi volumio[23541]: info: CoreStateMachine::pushState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioPushState Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:44:40 simonpi volumio[23541]: info: Received Get System Info Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:44:40 simonpi volumio[23541]: info: Discovery: Getting this device information Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:40 simonpi volumio[23541]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:40 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:40 simonpi volumio[23541]: info: Listing playlists Jun 30 11:44:40 simonpi volumio[23541]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:41 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:44:41 simonpi volumio[23541]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:44:41 simonpi volumio[23541]: info: Discovery: Found device SimonPi Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::volumioGetState Jun 30 11:44:41 simonpi volumio[23541]: info: CorePlayQueue::getTrack 0 Jun 30 11:44:41 simonpi volumio[23541]: info: Completed loading Core Plugins Jun 30 11:44:41 simonpi volumio[23541]: info: Preparing to generate the ALSA configuration file Jun 30 11:44:41 simonpi volumio[23541]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:44:41 simonpi volumio[23541]: info: Reading ALSA contributions from plugins. Jun 30 11:44:41 simonpi volumio[23541]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:44:41 simonpi volumio[23541]: info: Output device has changed, restarting MPD Jun 30 11:44:41 simonpi volumio[23541]: info: Output device has changed, restarting Shairport Sync Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:41 simonpi sudo[23647]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:41 simonpi sudo[23647]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:41 simonpi sudo[23647]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:41 simonpi sudo[23649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:41 simonpi sudo[23649]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:41 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:44:41 simonpi volumio[23541]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:41 simonpi volumio[23541]: info: ___________ START PLUGINS ___________ Jun 30 11:44:41 simonpi volumio[23541]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:44:41 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:41 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:41 simonpi volumio[23541]: info: Creating MPD Configuration file Jun 30 11:44:41 simonpi sudo[23657]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:44:41 simonpi sudo[23657]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:41 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:41 simonpi sudo[23657]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:41 simonpi sudo[23659]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:44:41 simonpi sudo[23659]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:41 simonpi volumio[23541]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:41 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:44:41 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:44:41 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:44:41 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:44:41 simonpi volumio[23541]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:44:41 simonpi volumio[23541]: info: [1751280281672] CoreMusicLibrary::Adding element Last_100 Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:44:41 simonpi volumio[23541]: info: [1751280281686] CoreMusicLibrary::Adding element Webradio Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:41 simonpi volumio[23541]: info: Initializing BBC Radios Jun 30 11:44:41 simonpi volumio[23541]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:41 simonpi sudo[23674]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:44:41 simonpi sudo[23674]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:41 simonpi sudo[23674]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:41 simonpi volumio[23541]: info: Loading i18n strings for locale en Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:44:41 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:41 simonpi volumio[23541]: info: FusionDsp - mixtype--------------------- undefined Jun 30 11:44:41 simonpi volumio[23541]: info: Volumio Calling Home Jun 30 11:44:41 simonpi volumio[23541]: info: Preparing to generate the ALSA configuration file Jun 30 11:44:42 simonpi volumio[23541]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:44:42 simonpi volumio[23541]: info: Reading ALSA contributions from plugins. Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:44:42 simonpi volumio[23541]: info: MPD Permissions set Jun 30 11:44:42 simonpi volumio[23541]: info: MPD Permissions set Jun 30 11:44:42 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:42 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 306. Jun 30 11:44:42 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:42 simonpi volumio[23541]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:42 simonpi volumio[23541]: info: Volumio called home Jun 30 11:44:42 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:42 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:43 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:43 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:43 simonpi mpd[23696]: Jun 30 11:44 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:44:43 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:44:43 simonpi sudo[23649]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:43 simonpi sudo[23659]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:43 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:44 simonpi volumio[23700]: Traceback (most recent call last): Jun 30 11:44:44 simonpi volumio[23700]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:44 simonpi volumio[23700]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:44 simonpi volumio[23700]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:44 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:44 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:44 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:44 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:44 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:45 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:45 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:45 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:45 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:46 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:46 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:46 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 307. Jun 30 11:44:46 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:46 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:46 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:46 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:46 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:46 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:47 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:47 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:47 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:47 simonpi volumio[23712]: Traceback (most recent call last): Jun 30 11:44:47 simonpi volumio[23712]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:47 simonpi volumio[23712]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:47 simonpi volumio[23712]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:47 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:48 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:48 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:48 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:48 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:48 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:48 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:49 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:49 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:49 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:49 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:49 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:50 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:50 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:50 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 308. Jun 30 11:44:50 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:50 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:50 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:50 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:51 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:51 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:51 simonpi volumio[23541]: info: FusionDsp - Jun 30 11:44:51 simonpi volumio[23541]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:44:51 simonpi volumio[23541]: 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 30 11:44:51 simonpi volumio[23541]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:44:51 simonpi volumio[23541]: info: camilladsp service started and running in background, instance 1 Jun 30 11:44:51 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:44:51 simonpi volumio[23541]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:44:51 simonpi volumio[23541]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 30 11:44:51 simonpi volumio[23541]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:44:51 simonpi volumio[23541]: info: FusionDsp loaded Jun 30 11:44:51 simonpi volumio[23541]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:44:51 simonpi sudo[23738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:44:51 simonpi sudo[23738]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:51 simonpi volumio[23727]: Traceback (most recent call last): Jun 30 11:44:51 simonpi volumio[23727]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:51 simonpi volumio[23727]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:51 simonpi volumio[23727]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:52 simonpi sudo[23738]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:52 simonpi volumio[23541]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:44:52 simonpi volumio[23541]: info: Adding Signal Path Element [object Object] Jun 30 11:44:52 simonpi volumio[23541]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:44:52 simonpi volumio[23541]: info: FusionDsp - ---- installed callbackRead Jun 30 11:44:52 simonpi volumio[23541]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:44:52 simonpi volumio[23541]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:44:52 simonpi volumio[23541]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:44:52 simonpi volumio[23541]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:44:52 simonpi volumio[23541]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 30 11:44:52 simonpi volumio[23541]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 30 11:44:52 simonpi volumio[23541]: at listOnTimeout (internal/timers.js:523:9) Jun 30 11:44:52 simonpi volumio[23541]: at processTimers (internal/timers.js:497:7) { Jun 30 11:44:52 simonpi volumio[23541]: errno: -2, Jun 30 11:44:52 simonpi volumio[23541]: code: 'ENOENT', Jun 30 11:44:52 simonpi volumio[23541]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:44:52 simonpi volumio[23541]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:44:52 simonpi volumio[23541]: spawnargs: [ Jun 30 11:44:52 simonpi volumio[23541]: '-p', Jun 30 11:44:52 simonpi volumio[23541]: 9876, Jun 30 11:44:52 simonpi volumio[23541]: '-o', Jun 30 11:44:52 simonpi volumio[23541]: '/tmp/camilladsp.log', Jun 30 11:44:52 simonpi volumio[23541]: '-l', Jun 30 11:44:52 simonpi volumio[23541]: 'warn', Jun 30 11:44:52 simonpi volumio[23541]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:44:52 simonpi volumio[23541]: ] Jun 30 11:44:52 simonpi volumio[23541]: } Jun 30 11:44:52 simonpi volumio[23541]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:44:52 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:52 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:52 simonpi sudo[23752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:43 Jun 30 11:44:52 simonpi sudo[23752]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:53 simonpi sudo[23752]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:53 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:53] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:44:53 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:53] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:44:53 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:53 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:44:53 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:44:53 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:44:53 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:44:53 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 90. Jun 30 11:44:53 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:44:53 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:44:53 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:44:53 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:44:54 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:54 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 309. Jun 30 11:44:54 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:54 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:55 simonpi volumio[23762]: info: ------------------------------------------- Jun 30 11:44:55 simonpi volumio[23762]: info: ----- Volumio3 ---- Jun 30 11:44:55 simonpi volumio[23762]: info: ------------------------------------------- Jun 30 11:44:55 simonpi volumio[23762]: info: ----- System startup ---- Jun 30 11:44:55 simonpi volumio[23762]: info: ------------------------------------------- Jun 30 11:44:55 simonpi volumio[23775]: Traceback (most recent call last): Jun 30 11:44:55 simonpi volumio[23775]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:44:55 simonpi volumio[23775]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:44:55 simonpi volumio[23775]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:44:56 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:44:56 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:44:56 simonpi volumio[23762]: info: MYVOLUMIO Environment detected Jun 30 11:44:56 simonpi volumio[23762]: info: Plugin folders cleanup Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning category audio_interface Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning category miscellanea Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning category music_service Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning category plugins.json Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning category system_controller Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning category user_interface Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning into folder /data/plugins/ Jun 30 11:44:56 simonpi volumio[23762]: info: Scanning category audio_interface Jun 30 11:44:56 simonpi volumio[23762]: info: Plugin folders cleanup completed Jun 30 11:44:56 simonpi volumio[23762]: info: ------------------------------------------- Jun 30 11:44:56 simonpi volumio[23762]: info: ----- Core plugins startup ---- Jun 30 11:44:56 simonpi volumio[23762]: info: ------------------------------------------- Jun 30 11:44:56 simonpi volumio[23762]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:44:56 simonpi volumio[23762]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:44:56 simonpi volumio[23762]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:44:56 simonpi volumio[23762]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:44:56 simonpi volumio[23762]: info: Loading plugins from folder /data/plugins/ Jun 30 11:44:56 simonpi volumio[23762]: info: Loading plugin "system"... Jun 30 11:44:56 simonpi volumio[23762]: info: Loading plugin "appearance"... Jun 30 11:44:57 simonpi volumio[23762]: info: Loading plugin "network"... Jun 30 11:44:57 simonpi volumio[23762]: info: Refreshing Cached IP Addresses Jun 30 11:44:57 simonpi sudo[23790]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:44:57 simonpi sudo[23790]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:57 simonpi sudo[23792]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:44:57 simonpi sudo[23792]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:57 simonpi sudo[23792]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:57 simonpi volumio[23762]: info: Loading plugin "services"... Jun 30 11:44:57 simonpi volumio[23762]: info: Loading plugin "alsa_controller"... Jun 30 11:44:57 simonpi sudo[23790]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:57 simonpi sudo[23804]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:44:57 simonpi sudo[23804]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:44:57 simonpi volumio[23762]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device. Jun 30 11:44:57 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:44:57 simonpi volumio[23762]: info: Loading plugin "wizard"... Jun 30 11:44:57 simonpi volumio[23762]: info: Loading plugin "networkfs"... Jun 30 11:44:57 simonpi volumio[23762]: info: Starting Udev Watcher for removable devices Jun 30 11:44:58 simonpi volumio[23762]: info: Ignoring mount for partition: boot Jun 30 11:44:58 simonpi volumio[23762]: info: Ignoring mount for partition: volumio Jun 30 11:44:58 simonpi volumio[23762]: info: Ignoring mount for partition: volumio_data Jun 30 11:44:58 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "upnp"... Jun 30 11:44:58 simonpi volumio[23762]: info: [1751280298024] Starting Upmpd Daemon Jun 30 11:44:58 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "my_music"... Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "mpd"... Jun 30 11:44:58 simonpi volumio-remote-updater[524]: [2025-06-30 11:44:58] [connect] Successful connection Jun 30 11:44:58 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:44:58 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 310. Jun 30 11:44:58 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:44:58 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:44:58 simonpi volumio[23762]: info: Plugin upnp_browser is not enabled Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "alarm-clock"... Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "airplay_emulation"... Jun 30 11:44:58 simonpi volumio[23762]: info: Starting Shairport Sync Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "last_100"... Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "webradio"... Jun 30 11:44:58 simonpi sudo[23804]: pam_unix(sudo:session): session closed for user root Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "i2s_dacs"... Jun 30 11:44:58 simonpi volumio[23762]: info: I2S DAC not set, start Auto-detection Jun 30 11:44:58 simonpi volumio[23762]: info: Loading plugin "volumiodiscovery"... Jun 30 11:44:58 simonpi volumio[23762]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:58 simonpi volumio[23762]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:58 simonpi volumio[23762]: *** WARNING *** For more information see Jun 30 11:44:58 simonpi node[23762]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:58 simonpi volumio[23762]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:58 simonpi volumio[23762]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:58 simonpi volumio[23762]: *** WARNING *** For more information see Jun 30 11:44:58 simonpi node[23762]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:58 simonpi node[23762]: *** WARNING *** For more information see Jun 30 11:44:58 simonpi node[23762]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:44:58 simonpi node[23762]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:44:58 simonpi node[23762]: *** WARNING *** For more information see Jun 30 11:44:58 simonpi volumio[23762]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:44:58 simonpi volumio[23762]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:44:59 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:44:59 simonpi volumio[23762]: info: Loading plugin "outputs"... Jun 30 11:44:59 simonpi volumio[23762]: info: Loading plugin "albumart"... Jun 30 11:44:59 simonpi volumio[23762]: info: Plugin example_plugin is not enabled Jun 30 11:44:59 simonpi volumio[23762]: info: Loading plugin "inputs"... Jun 30 11:44:59 simonpi volumio[23762]: info: Loading plugin "updater_comm"... Jun 30 11:44:59 simonpi volumio[23762]: info: Plugin mpdemulation is not enabled Jun 30 11:44:59 simonpi volumio[23762]: info: Loading plugin "rest_api"... Jun 30 11:44:59 simonpi volumio[23762]: info: Loading plugin "websocket"... Jun 30 11:44:59 simonpi volumio[23762]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:44:59 simonpi volumio[23762]: info: Loading plugin "fusiondsp"... Jun 30 11:44:59 simonpi volumio[23762]: Forking 3 albumart workers Jun 30 11:44:59 simonpi volumio[23762]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:45:00 simonpi volumio[23817]: Traceback (most recent call last): Jun 30 11:45:00 simonpi volumio[23817]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:00 simonpi volumio[23817]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:00 simonpi volumio[23817]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:00 simonpi volumio[23762]: info: Loading i18n strings for locale en Jun 30 11:45:00 simonpi volumio[23762]: Updating browse sources language Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:00 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:00 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::initPlayerControls Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: Express server listening on port 3000 Jun 30 11:45:00 simonpi volumio[23762]: [Metrics] WebUI: 5s 779.86ms Jun 30 11:45:00 simonpi volumio[23762]: info: CoreStateMachine::resetVolumioState Jun 30 11:45:00 simonpi volumio[23762]: info: CoreStateMachine::getcurrentVolume Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:00 simonpi volumio[23762]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:45:00 simonpi volumio[23762]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:45:00 simonpi volumio[23762]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Jun 30 11:45:00 simonpi volumio[23762]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jun 30 11:45:00 simonpi volumio[23762]: Starting albumart workers Jun 30 11:45:00 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280298 101 Jun 30 11:45:00 simonpi volumio[23762]: 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: 3 Jun 30 11:45:00 simonpi volumio[23762]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:45:00 simonpi volumio[23762]: info: CoreStateMachine::pushState Jun 30 11:45:00 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:00 simonpi volumio[23762]: info: CoreStateMachine::updateTrackBlock Jun 30 11:45:00 simonpi volumio[23762]: info: CorePlayQueue::getTrackBlock Jun 30 11:45:00 simonpi volumio[23762]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:45:01 simonpi volumio[23762]: Starting albumart workers Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:45:01 simonpi volumio[23762]: info: Discovery: Getting this device information Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:45:01 simonpi volumio[23762]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:45:01 simonpi volumio[23762]: Starting albumart workers Jun 30 11:45:01 simonpi volumio[23762]: info: Reloading queue from file Jun 30 11:45:01 simonpi volumio[23762]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:45:01 simonpi volumio[23762]: info: CoreStateMachine::pushState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:01 simonpi volumio[23762]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:45:01 simonpi volumio[23762]: info: CoreStateMachine::pushState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:01 simonpi volumio[23762]: info: CoreStateMachine::setRandom null Jun 30 11:45:01 simonpi volumio[23762]: info: CoreStateMachine::pushState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:01 simonpi volumio[23762]: info: Setting Device type: Raspberry PI Jun 30 11:45:01 simonpi volumio[23762]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:45:01 simonpi volumio[23762]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:45:01 simonpi volumio[23762]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:45:01 simonpi volumio[23762]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Jun 30 11:45:01 simonpi volumio[23762]: info: Completed loading Core Plugins Jun 30 11:45:01 simonpi volumio[23762]: info: Preparing to generate the ALSA configuration file Jun 30 11:45:01 simonpi volumio[23762]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:45:01 simonpi volumio[23762]: info: Reading ALSA contributions from plugins. Jun 30 11:45:01 simonpi volumio[23762]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:45:01 simonpi volumio[23762]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:45:01 simonpi volumio[23762]: info: Discovery: Found device SimonPi Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:45:01 simonpi volumio[23762]: info: Received Get System Info Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:45:01 simonpi volumio[23762]: info: Discovery: Getting this device information Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:01 simonpi volumio[23762]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:01 simonpi volumio[23762]: info: Listing playlists Jun 30 11:45:01 simonpi volumio[23762]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:45:01 simonpi volumio[23762]: info: Output device has changed, restarting MPD Jun 30 11:45:01 simonpi volumio[23762]: info: Output device has changed, restarting Shairport Sync Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:01 simonpi sudo[23869]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:45:01 simonpi sudo[23869]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:01 simonpi sudo[23869]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:01 simonpi sudo[23871]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:45:01 simonpi sudo[23871]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:01 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:45:01 simonpi volumio[23762]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:45:01 simonpi volumio[23762]: info: ___________ START PLUGINS ___________ Jun 30 11:45:01 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:45:01 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:45:01 simonpi volumio[23762]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:45:01 simonpi volumio[23762]: info: Creating MPD Configuration file Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:01 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:01 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:45:01 simonpi sudo[23887]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:45:01 simonpi sudo[23887]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:01 simonpi sudo[23887]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:01 simonpi sudo[23893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:45:01 simonpi sudo[23893]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:02 simonpi volumio[23762]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:02 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:45:02 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:45:02 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:02 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:45:02 simonpi volumio[23762]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:45:02 simonpi volumio[23762]: info: [1751280302086] CoreMusicLibrary::Adding element Last_100 Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:45:02 simonpi volumio[23762]: info: [1751280302096] CoreMusicLibrary::Adding element Webradio Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:45:02 simonpi volumio[23762]: info: Initializing BBC Radios Jun 30 11:45:02 simonpi volumio[23762]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:02 simonpi sudo[23903]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:45:02 simonpi sudo[23903]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:02 simonpi volumio[23762]: info: Loading i18n strings for locale en Jun 30 11:45:02 simonpi sudo[23903]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:02 simonpi volumio[23762]: info: FusionDsp - mixtype--------------------- undefined Jun 30 11:45:02 simonpi volumio[23762]: info: Volumio Calling Home Jun 30 11:45:02 simonpi volumio[23762]: info: Preparing to generate the ALSA configuration file Jun 30 11:45:02 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:02 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 311. Jun 30 11:45:02 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:02 simonpi volumio[23762]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:45:02 simonpi volumio[23762]: info: Reading ALSA contributions from plugins. Jun 30 11:45:02 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:02 simonpi volumio[23762]: info: MPD Permissions set Jun 30 11:45:02 simonpi volumio[23762]: info: MPD Permissions set Jun 30 11:45:02 simonpi volumio[23762]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jun 30 11:45:02 simonpi volumio[23762]: info: Volumio called home Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:02 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:03 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:03 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:03 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:04 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:04 simonpi mpd[23918]: Jun 30 11:45 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:45:04 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:45:04 simonpi sudo[23871]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:04 simonpi sudo[23893]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:04 simonpi volumio[23922]: Traceback (most recent call last): Jun 30 11:45:04 simonpi volumio[23922]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:04 simonpi volumio[23922]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:04 simonpi volumio[23922]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:04 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:04 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:04 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:04 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:05 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:05 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:05 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:05 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:06 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:06 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:06 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:06 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 312. Jun 30 11:45:06 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:06 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:06 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:06 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:07 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:07 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:07 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:07 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:08 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:08 simonpi volumio[23934]: Traceback (most recent call last): Jun 30 11:45:08 simonpi volumio[23934]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:08 simonpi volumio[23934]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:08 simonpi volumio[23934]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:08 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:08 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:08 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:08 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:08 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:08 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:09 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:09 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:09 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:09 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:10 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:10 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:10 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:10 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:10 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 313. Jun 30 11:45:10 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:10 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:11 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:11 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:11 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:11 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:11 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:12 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:12 simonpi volumio[23949]: Traceback (most recent call last): Jun 30 11:45:12 simonpi volumio[23949]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:12 simonpi volumio[23949]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:12 simonpi volumio[23949]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:12 simonpi volumio[23762]: info: FusionDsp - Jun 30 11:45:12 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:12 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:12 simonpi volumio[23762]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:45:12 simonpi volumio[23762]: 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 30 11:45:12 simonpi volumio[23762]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:45:12 simonpi volumio[23762]: info: camilladsp service started and running in background, instance 1 Jun 30 11:45:12 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:12 simonpi volumio[23762]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:45:12 simonpi volumio[23762]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 30 11:45:12 simonpi volumio[23762]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:45:12 simonpi volumio[23762]: info: FusionDsp loaded Jun 30 11:45:12 simonpi volumio[23762]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:45:12 simonpi sudo[23962]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:45:12 simonpi sudo[23962]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:12 simonpi volumio[23762]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:45:12 simonpi volumio[23762]: info: Adding Signal Path Element [object Object] Jun 30 11:45:12 simonpi volumio[23762]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:45:12 simonpi volumio[23762]: info: FusionDsp - ---- installed callbackRead Jun 30 11:45:12 simonpi volumio[23762]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:45:12 simonpi volumio[23762]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:45:12 simonpi volumio[23762]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:45:12 simonpi volumio[23762]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:45:12 simonpi volumio[23762]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 30 11:45:12 simonpi volumio[23762]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 30 11:45:12 simonpi volumio[23762]: at listOnTimeout (internal/timers.js:523:9) Jun 30 11:45:12 simonpi volumio[23762]: at processTimers (internal/timers.js:497:7) { Jun 30 11:45:12 simonpi volumio[23762]: errno: -2, Jun 30 11:45:12 simonpi volumio[23762]: code: 'ENOENT', Jun 30 11:45:12 simonpi volumio[23762]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:45:12 simonpi volumio[23762]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:45:12 simonpi volumio[23762]: spawnargs: [ Jun 30 11:45:12 simonpi volumio[23762]: '-p', Jun 30 11:45:12 simonpi volumio[23762]: 9876, Jun 30 11:45:12 simonpi volumio[23762]: '-o', Jun 30 11:45:12 simonpi volumio[23762]: '/tmp/camilladsp.log', Jun 30 11:45:12 simonpi volumio[23762]: '-l', Jun 30 11:45:12 simonpi volumio[23762]: 'warn', Jun 30 11:45:12 simonpi volumio[23762]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:45:12 simonpi volumio[23762]: ] Jun 30 11:45:12 simonpi volumio[23762]: } Jun 30 11:45:12 simonpi volumio[23762]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:45:13 simonpi sudo[23974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:44 Jun 30 11:45:13 simonpi sudo[23974]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:13 simonpi sudo[23974]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:13 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:13] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:45:13 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:13] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:45:13 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:13 simonpi sudo[23962]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:13 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:45:13 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:45:13 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:45:14 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:45:14 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 91. Jun 30 11:45:14 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:45:14 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:45:14 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:45:14 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:45:14 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:14 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 314. Jun 30 11:45:14 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:14 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:16 simonpi volumio[23997]: Traceback (most recent call last): Jun 30 11:45:16 simonpi volumio[23997]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:16 simonpi volumio[23997]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:16 simonpi volumio[23997]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:16 simonpi volumio[23984]: info: ------------------------------------------- Jun 30 11:45:16 simonpi volumio[23984]: info: ----- Volumio3 ---- Jun 30 11:45:16 simonpi volumio[23984]: info: ------------------------------------------- Jun 30 11:45:16 simonpi volumio[23984]: info: ----- System startup ---- Jun 30 11:45:16 simonpi volumio[23984]: info: ------------------------------------------- Jun 30 11:45:16 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:16 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:17 simonpi volumio[23984]: info: MYVOLUMIO Environment detected Jun 30 11:45:17 simonpi volumio[23984]: info: Plugin folders cleanup Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning category audio_interface Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning category miscellanea Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning category music_service Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning category plugins.json Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning category system_controller Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning category user_interface Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning into folder /data/plugins/ Jun 30 11:45:17 simonpi volumio[23984]: info: Scanning category audio_interface Jun 30 11:45:17 simonpi volumio[23984]: info: Plugin folders cleanup completed Jun 30 11:45:17 simonpi volumio[23984]: info: ------------------------------------------- Jun 30 11:45:17 simonpi volumio[23984]: info: ----- Core plugins startup ---- Jun 30 11:45:17 simonpi volumio[23984]: info: ------------------------------------------- Jun 30 11:45:17 simonpi volumio[23984]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:45:17 simonpi volumio[23984]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:45:17 simonpi volumio[23984]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:45:17 simonpi volumio[23984]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:45:17 simonpi volumio[23984]: info: Loading plugins from folder /data/plugins/ Jun 30 11:45:17 simonpi volumio[23984]: info: Loading plugin "system"... Jun 30 11:45:17 simonpi volumio[23984]: info: Loading plugin "appearance"... Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "network"... Jun 30 11:45:18 simonpi volumio[23984]: info: Refreshing Cached IP Addresses Jun 30 11:45:18 simonpi sudo[24012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:45:18 simonpi sudo[24012]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:18 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:18 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 315. Jun 30 11:45:18 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:18 simonpi sudo[24014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:45:18 simonpi sudo[24014]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "services"... Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "alsa_controller"... Jun 30 11:45:18 simonpi sudo[24012]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:18 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:18 simonpi sudo[24014]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:18 simonpi sudo[24026]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:45:18 simonpi sudo[24026]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:18 simonpi volumio[23984]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device. Jun 30 11:45:18 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "wizard"... Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "networkfs"... Jun 30 11:45:18 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:18] [connect] Successful connection Jun 30 11:45:18 simonpi volumio[23984]: info: Starting Udev Watcher for removable devices Jun 30 11:45:18 simonpi volumio[23984]: info: Ignoring mount for partition: boot Jun 30 11:45:18 simonpi volumio[23984]: info: Ignoring mount for partition: volumio Jun 30 11:45:18 simonpi volumio[23984]: info: Ignoring mount for partition: volumio_data Jun 30 11:45:18 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "upnp"... Jun 30 11:45:18 simonpi volumio[23984]: info: [1751280318793] Starting Upmpd Daemon Jun 30 11:45:18 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "my_music"... Jun 30 11:45:18 simonpi volumio[23984]: info: Loading plugin "mpd"... Jun 30 11:45:19 simonpi volumio[23984]: info: Plugin upnp_browser is not enabled Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "alarm-clock"... Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "airplay_emulation"... Jun 30 11:45:19 simonpi volumio[23984]: info: Starting Shairport Sync Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "last_100"... Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "webradio"... Jun 30 11:45:19 simonpi sudo[24026]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "i2s_dacs"... Jun 30 11:45:19 simonpi volumio[23984]: info: I2S DAC not set, start Auto-detection Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "volumiodiscovery"... Jun 30 11:45:19 simonpi volumio[23984]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:19 simonpi volumio[23984]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:19 simonpi volumio[23984]: *** WARNING *** For more information see Jun 30 11:45:19 simonpi node[23984]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:19 simonpi volumio[23984]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:19 simonpi volumio[23984]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:19 simonpi volumio[23984]: *** WARNING *** For more information see Jun 30 11:45:19 simonpi node[23984]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:19 simonpi node[23984]: *** WARNING *** For more information see Jun 30 11:45:19 simonpi node[23984]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:19 simonpi node[23984]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:19 simonpi node[23984]: *** WARNING *** For more information see Jun 30 11:45:19 simonpi volumio[23984]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:45:19 simonpi volumio[23984]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:45:19 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "outputs"... Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "albumart"... Jun 30 11:45:19 simonpi volumio[23984]: info: Plugin example_plugin is not enabled Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "inputs"... Jun 30 11:45:19 simonpi volumio[23984]: info: Loading plugin "updater_comm"... Jun 30 11:45:20 simonpi volumio[23984]: info: Plugin mpdemulation is not enabled Jun 30 11:45:20 simonpi volumio[23984]: info: Loading plugin "rest_api"... Jun 30 11:45:20 simonpi volumio[23984]: info: Loading plugin "websocket"... Jun 30 11:45:20 simonpi volumio[23984]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:45:20 simonpi volumio[23984]: info: Loading plugin "fusiondsp"... Jun 30 11:45:20 simonpi volumio[24023]: Traceback (most recent call last): Jun 30 11:45:20 simonpi volumio[24023]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:20 simonpi volumio[24023]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:20 simonpi volumio[24023]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:20 simonpi volumio[23984]: Forking 3 albumart workers Jun 30 11:45:20 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:20 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:20 simonpi volumio[23984]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:45:20 simonpi volumio[23984]: info: Loading i18n strings for locale en Jun 30 11:45:20 simonpi volumio[23984]: Updating browse sources language Jun 30 11:45:20 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::initPlayerControls Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: Express server listening on port 3000 Jun 30 11:45:21 simonpi volumio[23984]: [Metrics] WebUI: 5s 647.94ms Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::resetVolumioState Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::getcurrentVolume Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:21 simonpi volumio[23984]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:45:21 simonpi volumio[23984]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:45:21 simonpi volumio[23984]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Jun 30 11:45:21 simonpi volumio[23984]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Jun 30 11:45:21 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:21] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280318 101 Jun 30 11:45:21 simonpi volumio[23984]: 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: 3 Jun 30 11:45:21 simonpi volumio[23984]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::pushState Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::updateTrackBlock Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrackBlock Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:45:21 simonpi volumio[23984]: Starting albumart workers Jun 30 11:45:21 simonpi volumio[23984]: Starting albumart workers Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:45:21 simonpi volumio[23984]: info: Discovery: Getting this device information Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:45:21 simonpi volumio[23984]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 30 11:45:21 simonpi volumio[23984]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:45:21 simonpi volumio[23984]: Starting albumart workers Jun 30 11:45:21 simonpi volumio[23984]: info: Reloading queue from file Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::pushState Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::setRandom null Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::pushState Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:21 simonpi volumio[23984]: info: Setting Device type: Raspberry PI Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:45:21 simonpi volumio[23984]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:45:21 simonpi volumio[23984]: info: CoreStateMachine::pushState Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:21 simonpi volumio[23984]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:45:21 simonpi volumio[23984]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:45:21 simonpi volumio[23984]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:45:21 simonpi volumio[23984]: info: Received Get System Info Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:45:21 simonpi volumio[23984]: info: Discovery: Getting this device information Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:21 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:21 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:22 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:22 simonpi volumio[23984]: info: Listing playlists Jun 30 11:45:22 simonpi volumio[23984]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:22 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:45:22 simonpi volumio[23984]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:45:22 simonpi volumio[23984]: info: Discovery: Found device SimonPi Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:22 simonpi volumio[23984]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:22 simonpi volumio[23984]: info: Completed loading Core Plugins Jun 30 11:45:22 simonpi volumio[23984]: info: Preparing to generate the ALSA configuration file Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:22 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 316. Jun 30 11:45:22 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:22 simonpi volumio[23984]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:45:22 simonpi volumio[23984]: info: Reading ALSA contributions from plugins. Jun 30 11:45:22 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:23 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:23 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:23 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:23 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:24 simonpi volumio[24106]: Traceback (most recent call last): Jun 30 11:45:24 simonpi volumio[24106]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:24 simonpi volumio[24106]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:24 simonpi volumio[24106]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:24 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:24 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:24 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:24 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:24 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:25 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:25 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:25 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:25 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:26 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:26 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:26 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:26 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 317. Jun 30 11:45:26 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:26 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:26 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:26 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:27 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:27 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:27 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:28 simonpi volumio[24146]: Traceback (most recent call last): Jun 30 11:45:28 simonpi volumio[24146]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:28 simonpi volumio[24146]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:28 simonpi volumio[24146]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:28 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:28 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:28 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:28 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:28 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:28 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:29 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:29 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:29 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:29 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:30 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:30 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:30 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:30 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:30 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 318. Jun 30 11:45:30 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:30 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:30 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:30 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:31 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:31 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:31 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:32 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:32 simonpi volumio[24161]: Traceback (most recent call last): Jun 30 11:45:32 simonpi volumio[24161]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:32 simonpi volumio[24161]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:32 simonpi volumio[24161]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:32 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:32 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:32 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:32 simonpi volumio[23984]: info: FusionDsp - Jun 30 11:45:32 simonpi sudo[24163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:45:32 simonpi sudo[24163]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:32 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:32 simonpi sudo[24163]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:32 simonpi sudo[24171]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:45:32 simonpi sudo[24171]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:32 simonpi sudo[24171]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:32 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:32 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:33 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:34 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 319. Jun 30 11:45:34 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:34 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:35 simonpi volumio[23984]: info: FusionDsp - undefined Jun 30 11:45:35 simonpi volumio[23984]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:45:35 simonpi volumio[23984]: TypeError: Cannot read property 'off' of undefined Jun 30 11:45:35 simonpi volumio[23984]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Jun 30 11:45:35 simonpi volumio[23984]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 30 11:45:35 simonpi volumio[23984]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Jun 30 11:45:35 simonpi volumio[23984]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Jun 30 11:45:35 simonpi volumio[23984]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Jun 30 11:45:35 simonpi volumio[23984]: at Socket.emit (events.js:315:20) Jun 30 11:45:35 simonpi volumio[23984]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 30 11:45:35 simonpi volumio[23984]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 30 11:45:35 simonpi volumio[23984]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:45:35 simonpi sudo[24184]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:44 Jun 30 11:45:35 simonpi sudo[24184]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:36 simonpi sudo[24184]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:36 simonpi volumio[24173]: Traceback (most recent call last): Jun 30 11:45:36 simonpi volumio[24173]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:36 simonpi volumio[24173]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:36 simonpi volumio[24173]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:36 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:36 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:36 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:36] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:45:36 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:36] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:45:36 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:36 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:45:36 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:45:36 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:45:36 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:45:36 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 92. Jun 30 11:45:36 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:45:36 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:45:36 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:45:36 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:45:38 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:38 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 320. Jun 30 11:45:38 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:38 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:38 simonpi volumio[24197]: info: ------------------------------------------- Jun 30 11:45:38 simonpi volumio[24197]: info: ----- Volumio3 ---- Jun 30 11:45:38 simonpi volumio[24197]: info: ------------------------------------------- Jun 30 11:45:38 simonpi volumio[24197]: info: ----- System startup ---- Jun 30 11:45:38 simonpi volumio[24197]: info: ------------------------------------------- Jun 30 11:45:39 simonpi volumio[24197]: info: MYVOLUMIO Environment detected Jun 30 11:45:39 simonpi volumio[24197]: info: Plugin folders cleanup Jun 30 11:45:39 simonpi volumio[24197]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:45:39 simonpi volumio[24197]: info: Scanning category audio_interface Jun 30 11:45:39 simonpi volumio[24197]: info: Scanning category miscellanea Jun 30 11:45:40 simonpi volumio[24197]: info: Scanning category music_service Jun 30 11:45:40 simonpi volumio[24197]: info: Scanning category plugins.json Jun 30 11:45:40 simonpi volumio[24197]: info: Scanning category system_controller Jun 30 11:45:40 simonpi volumio[24197]: info: Scanning category user_interface Jun 30 11:45:40 simonpi volumio[24197]: info: Scanning into folder /data/plugins/ Jun 30 11:45:40 simonpi volumio[24197]: info: Scanning category audio_interface Jun 30 11:45:40 simonpi volumio[24197]: info: Plugin folders cleanup completed Jun 30 11:45:40 simonpi volumio[24197]: info: ------------------------------------------- Jun 30 11:45:40 simonpi volumio[24197]: info: ----- Core plugins startup ---- Jun 30 11:45:40 simonpi volumio[24197]: info: ------------------------------------------- Jun 30 11:45:40 simonpi volumio[24197]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:45:40 simonpi volumio[24197]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:45:40 simonpi volumio[24197]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:45:40 simonpi volumio[24197]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:45:40 simonpi volumio[24197]: info: Loading plugins from folder /data/plugins/ Jun 30 11:45:40 simonpi volumio[24197]: info: Loading plugin "system"... Jun 30 11:45:40 simonpi volumio[24197]: info: Loading plugin "appearance"... Jun 30 11:45:40 simonpi volumio[24210]: Traceback (most recent call last): Jun 30 11:45:40 simonpi volumio[24210]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:40 simonpi volumio[24210]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:40 simonpi volumio[24210]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:40 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:40 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "network"... Jun 30 11:45:41 simonpi volumio[24197]: info: Refreshing Cached IP Addresses Jun 30 11:45:41 simonpi sudo[24225]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:45:41 simonpi sudo[24225]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:41 simonpi sudo[24227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:45:41 simonpi sudo[24227]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:41 simonpi sudo[24227]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "services"... Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "alsa_controller"... Jun 30 11:45:41 simonpi sudo[24225]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:41 simonpi sudo[24237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:45:41 simonpi sudo[24237]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:41 simonpi volumio[24197]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device. Jun 30 11:45:41 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "wizard"... Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "networkfs"... Jun 30 11:45:41 simonpi volumio[24197]: info: Starting Udev Watcher for removable devices Jun 30 11:45:41 simonpi volumio[24197]: info: Ignoring mount for partition: boot Jun 30 11:45:41 simonpi volumio[24197]: info: Ignoring mount for partition: volumio Jun 30 11:45:41 simonpi volumio[24197]: info: Ignoring mount for partition: volumio_data Jun 30 11:45:41 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "upnp"... Jun 30 11:45:41 simonpi volumio[24197]: info: [1751280341563] Starting Upmpd Daemon Jun 30 11:45:41 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "my_music"... Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "mpd"... Jun 30 11:45:41 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:41] [connect] Successful connection Jun 30 11:45:41 simonpi volumio[24197]: info: Plugin upnp_browser is not enabled Jun 30 11:45:41 simonpi volumio[24197]: info: Loading plugin "alarm-clock"... Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "airplay_emulation"... Jun 30 11:45:42 simonpi volumio[24197]: info: Starting Shairport Sync Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "last_100"... Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "webradio"... Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "i2s_dacs"... Jun 30 11:45:42 simonpi volumio[24197]: info: I2S DAC not set, start Auto-detection Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "volumiodiscovery"... Jun 30 11:45:42 simonpi sudo[24237]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:42 simonpi volumio[24197]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:42 simonpi volumio[24197]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:42 simonpi volumio[24197]: *** WARNING *** For more information see Jun 30 11:45:42 simonpi node[24197]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:42 simonpi volumio[24197]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:42 simonpi volumio[24197]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:42 simonpi volumio[24197]: *** WARNING *** For more information see Jun 30 11:45:42 simonpi node[24197]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:42 simonpi node[24197]: *** WARNING *** For more information see Jun 30 11:45:42 simonpi node[24197]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jun 30 11:45:42 simonpi node[24197]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:45:42 simonpi node[24197]: *** WARNING *** For more information see Jun 30 11:45:42 simonpi volumio[24197]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:45:42 simonpi volumio[24197]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:45:42 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "outputs"... Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "albumart"... Jun 30 11:45:42 simonpi volumio[24197]: info: Plugin example_plugin is not enabled Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "inputs"... Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "updater_comm"... Jun 30 11:45:42 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:42 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 321. Jun 30 11:45:42 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:42 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:42 simonpi volumio[24197]: info: Plugin mpdemulation is not enabled Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "rest_api"... Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "websocket"... Jun 30 11:45:42 simonpi volumio[24197]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:45:42 simonpi volumio[24197]: info: Loading plugin "fusiondsp"... Jun 30 11:45:43 simonpi volumio[24197]: Forking 3 albumart workers Jun 30 11:45:43 simonpi volumio[24197]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:45:43 simonpi volumio[24197]: info: Loading i18n strings for locale en Jun 30 11:45:43 simonpi volumio[24197]: Updating browse sources language Jun 30 11:45:43 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::initPlayerControls Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: Express server listening on port 3000 Jun 30 11:45:44 simonpi volumio[24197]: [Metrics] WebUI: 5s 865.32ms Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::resetVolumioState Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::getcurrentVolume Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:45:44 simonpi volumio[24197]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:45:44 simonpi volumio[24197]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jun 30 11:45:44 simonpi volumio[24197]: verbose: New Socket.io Connection to 192.168.1.139:3000 from 192.168.1.36 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Jun 30 11:45:44 simonpi volumio-remote-updater[524]: [2025-06-30 11:45:44] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280341 101 Jun 30 11:45:44 simonpi volumio[24197]: 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: 3 Jun 30 11:45:44 simonpi volumio[24197]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::pushState Jun 30 11:45:44 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:44 simonpi volumio[24260]: Traceback (most recent call last): Jun 30 11:45:44 simonpi volumio[24260]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:44 simonpi volumio[24260]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:44 simonpi volumio[24260]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::updateTrackBlock Jun 30 11:45:44 simonpi volumio[24197]: info: CorePlayQueue::getTrackBlock Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:45:44 simonpi volumio[24197]: Starting albumart workers Jun 30 11:45:44 simonpi volumio[24197]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number. Jun 30 11:45:44 simonpi volumio[24197]: Starting albumart workers Jun 30 11:45:44 simonpi volumio[24197]: info: Reloading queue from file Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::pushState Jun 30 11:45:44 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::setRandom null Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::pushState Jun 30 11:45:44 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:44 simonpi volumio[24197]: info: Setting Device type: Raspberry PI Jun 30 11:45:44 simonpi volumio[24197]: info: VolumeController:: Volume=undefined Mute =false Jun 30 11:45:44 simonpi volumio[24197]: info: CoreStateMachine::pushState Jun 30 11:45:44 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::volumioPushState Jun 30 11:45:44 simonpi volumio[24197]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:45:44 simonpi volumio[24197]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:45:44 simonpi volumio[24197]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:45:44 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:44 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:44 simonpi volumio[24197]: info: Completed loading Core Plugins Jun 30 11:45:44 simonpi volumio[24197]: info: Preparing to generate the ALSA configuration file Jun 30 11:45:44 simonpi volumio[24197]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:45:44 simonpi volumio[24197]: info: Discovery: Found device SimonPi Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:44 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:44 simonpi volumio[24197]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:45:44 simonpi volumio[24197]: info: Reading ALSA contributions from plugins. Jun 30 11:45:44 simonpi volumio[24197]: verbose: New Socket.io Connection to 192.168.1.139 from 192.168.1.36 UA: Mozilla/5.0 (Linux; Android 15; SM-S901B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.3 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jun 30 11:45:44 simonpi volumio[24197]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:45:44 simonpi volumio[24197]: info: Output device has changed, restarting MPD Jun 30 11:45:44 simonpi volumio[24197]: info: Output device has changed, restarting Shairport Sync Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:44 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:44 simonpi sudo[24297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:45:44 simonpi sudo[24297]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:44 simonpi sudo[24297]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:44 simonpi sudo[24299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:45:44 simonpi sudo[24299]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:44 simonpi volumio[24197]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:45:44 simonpi volumio[24197]: info: ___________ START PLUGINS ___________ Jun 30 11:45:44 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:45:45 simonpi volumio[24197]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:45:45 simonpi volumio[24197]: info: Creating MPD Configuration file Jun 30 11:45:45 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:45:45 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:45:45 simonpi volumio[24197]: Starting albumart workers Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:45 simonpi sudo[24307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:45:45 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:45:45 simonpi sudo[24307]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:45 simonpi sudo[24307]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:45 simonpi sudo[24309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:45:45 simonpi sudo[24309]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:45 simonpi volumio[24197]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:45 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:45:45 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:45:45 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:45:45 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:45:45 simonpi volumio[24197]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:45:45 simonpi volumio[24197]: info: [1751280345363] CoreMusicLibrary::Adding element Last_100 Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:45:45 simonpi volumio[24197]: info: [1751280345383] CoreMusicLibrary::Adding element Webradio Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:45:45 simonpi sudo[24318]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:45:45 simonpi sudo[24318]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:45 simonpi sudo[24318]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:45 simonpi volumio[24197]: info: Initializing BBC Radios Jun 30 11:45:45 simonpi volumio[24197]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:45 simonpi volumio[24197]: info: Loading i18n strings for locale en Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:45:45 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:45 simonpi volumio[24197]: info: FusionDsp - mixtype--------------------- undefined Jun 30 11:45:45 simonpi volumio[24197]: info: Volumio Calling Home Jun 30 11:45:45 simonpi volumio[24197]: info: Preparing to generate the ALSA configuration file Jun 30 11:45:46 simonpi volumio[24197]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:45:46 simonpi volumio[24197]: info: Reading ALSA contributions from plugins. Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:45:46 simonpi volumio[24197]: info: MPD Permissions set Jun 30 11:45:46 simonpi volumio[24197]: info: MPD Permissions set Jun 30 11:45:46 simonpi volumio[24197]: 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 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:46 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:45:46 simonpi volumio[24197]: info: Received Get System Info Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:45:46 simonpi volumio[24197]: info: Discovery: Getting this device information Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:46 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:46 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:46 simonpi volumio[24197]: info: Listing playlists Jun 30 11:45:46 simonpi volumio[24197]: info: Volumio called home Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: Starting Shairport Sync Jun 30 11:45:46 simonpi volumio[24197]: info: Starting Shairport Sync Jun 30 11:45:46 simonpi volumio[24197]: info: Starting Shairport Sync Jun 30 11:45:46 simonpi sudo[24367]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:45:46 simonpi sudo[24367]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:46 simonpi sudo[24369]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:45:46 simonpi sudo[24369]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:46 simonpi sudo[24372]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:45:46 simonpi sudo[24372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:46 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:45:46 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:45:46 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:45:46 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:45:46 simonpi sudo[24369]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:46 simonpi sudo[24367]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:46 simonpi sudo[24372]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::volumioGetState Jun 30 11:45:46 simonpi volumio[24197]: info: CorePlayQueue::getTrack 0 Jun 30 11:45:46 simonpi volumio[24197]: info: Shairport-Sync Started Jun 30 11:45:46 simonpi volumio[24197]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:45:46 simonpi volumio[24197]: info: Shairport-Sync Started Jun 30 11:45:46 simonpi volumio[24197]: info: Shairport-Sync Started Jun 30 11:45:46 simonpi volumio[24197]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:45:46 simonpi volumio[24197]: info: Output device has changed, restarting MPD Jun 30 11:45:46 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:46 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 322. Jun 30 11:45:46 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:46 simonpi volumio[24197]: info: Output device has changed, restarting Shairport Sync Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:46 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:46 simonpi sudo[24380]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:45:46 simonpi sudo[24380]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:46 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:46 simonpi sudo[24380]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:46 simonpi sudo[24382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:45:46 simonpi sudo[24382]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:46 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:45:46 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:45:46 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:45:46 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:45:46 simonpi volumio[24197]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi sudo[24388]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi sudo[24388]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi sudo[24388]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:45:47 simonpi volumio[24197]: info: MPD Permissions set Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:47 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:47 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:48 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:48 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:48 simonpi volumio[24379]: Traceback (most recent call last): Jun 30 11:45:48 simonpi volumio[24379]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:48 simonpi volumio[24379]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:48 simonpi volumio[24379]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:48 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:48 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:48 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:49 simonpi mpd[24391]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:45:49 simonpi mpd[24391]: output: No 'audio_output' defined in config file Jun 30 11:45:49 simonpi mpd[24391]: output: Successfully detected a sndio audio device Jun 30 11:45:49 simonpi mpd[24391]: zeroconf: No global port, disabling zeroconf Jun 30 11:45:49 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:45:49 simonpi sudo[24309]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:49 simonpi sudo[24382]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:49 simonpi sudo[24299]: pam_unix(sudo:session): session closed for user root Jun 30 11:45:49 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:49 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:49 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:50 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:50 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:50 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:50 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:50 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:50 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 323. Jun 30 11:45:50 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:50 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:51 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:51 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:51 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:51 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:51 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:52 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:52 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:52 simonpi volumio[24398]: Traceback (most recent call last): Jun 30 11:45:52 simonpi volumio[24398]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:52 simonpi volumio[24398]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:52 simonpi volumio[24398]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:52 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:52 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:52 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:52 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:53 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:53 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:53 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:53 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:53 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:54 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:54 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:54 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:54 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:54 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:45:54 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 324. Jun 30 11:45:54 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:45:54 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:45:54 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:55 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:55 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:55 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:56 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:56 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:56 simonpi volumio[24416]: Traceback (most recent call last): Jun 30 11:45:56 simonpi volumio[24416]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:45:56 simonpi volumio[24416]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:45:56 simonpi volumio[24416]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:45:56 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:56 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:45:56 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:45:56 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:56 simonpi volumio[24197]: info: FusionDsp - Jun 30 11:45:57 simonpi volumio[24197]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:45:57 simonpi volumio[24197]: 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 30 11:45:57 simonpi volumio[24197]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:45:57 simonpi volumio[24197]: info: camilladsp service started and running in background, instance 1 Jun 30 11:45:57 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:45:57 simonpi volumio[24197]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:45:57 simonpi volumio[24197]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jun 30 11:45:57 simonpi volumio[24197]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:45:57 simonpi volumio[24197]: info: FusionDsp loaded Jun 30 11:45:57 simonpi volumio[24197]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:45:57 simonpi sudo[24427]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:45:57 simonpi sudo[24427]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:45:57 simonpi volumio[24197]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:45:57 simonpi volumio[24197]: info: Adding Signal Path Element [object Object] Jun 30 11:45:57 simonpi volumio[24197]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:45:57 simonpi volumio[24197]: info: FusionDsp - ---- installed callbackRead Jun 30 11:45:57 simonpi volumio[24197]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:45:57 simonpi volumio[24197]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:45:57 simonpi volumio[24197]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:45:57 simonpi volumio[24197]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:45:57 simonpi volumio[24197]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 30 11:45:57 simonpi volumio[24197]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 30 11:45:57 simonpi volumio[24197]: at listOnTimeout (internal/timers.js:523:9) Jun 30 11:45:57 simonpi volumio[24197]: at processTimers (internal/timers.js:497:7) { Jun 30 11:45:57 simonpi volumio[24197]: errno: -2, Jun 30 11:45:57 simonpi volumio[24197]: code: 'ENOENT', Jun 30 11:45:57 simonpi volumio[24197]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:45:57 simonpi volumio[24197]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:45:57 simonpi volumio[24197]: spawnargs: [ Jun 30 11:45:57 simonpi volumio[24197]: '-p', Jun 30 11:45:57 simonpi volumio[24197]: 9876, Jun 30 11:45:57 simonpi volumio[24197]: '-o', Jun 30 11:45:57 simonpi volumio[24197]: '/tmp/camilladsp.log', Jun 30 11:45:57 simonpi volumio[24197]: '-l', Jun 30 11:45:57 simonpi volumio[24197]: 'warn', Jun 30 11:45:57 simonpi volumio[24197]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:45:57 simonpi volumio[24197]: ] Jun 30 11:45:57 simonpi volumio[24197]: } Jun 30 11:45:57 simonpi volumio[24197]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:45:58 simonpi sudo[24438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:44 Jun 30 11:45:58 simonpi sudo[24438]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="a142ed2648fb91920de0dde3a60cd39b5d0ba4f6" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="04c18c158cc4bac70764c3360b25fcce0c69266a" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 10 Jun 2025 04:52:53 PM CEST" VOLUMIO_VERSION="3.816" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a72866a0de4045751d03a035de6290e1"