-- Logs begin at Mon 2025-06-30 11:25:50 BST, end at Mon 2025-06-30 11:47:34 BST. --
Jun 30 11:46:00 simonpi volumio[24446]: Traceback (most recent call last):
Jun 30 11:46:00 simonpi volumio[24446]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:00 simonpi volumio[24446]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:00 simonpi volumio[24446]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:00 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:00 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:01 simonpi volumio[24452]: info: -------------------------------------------
Jun 30 11:46:01 simonpi volumio[24452]: info: ----- Volumio3 ----
Jun 30 11:46:01 simonpi volumio[24452]: info: -------------------------------------------
Jun 30 11:46:01 simonpi volumio[24452]: info: ----- System startup ----
Jun 30 11:46:01 simonpi volumio[24452]: info: -------------------------------------------
Jun 30 11:46:01 simonpi volumio[24452]: info: MYVOLUMIO Environment detected
Jun 30 11:46:02 simonpi volumio[24452]: info: Plugin folders cleanup
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning into folder /volumio/app/plugins/
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning category audio_interface
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning category miscellanea
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning category music_service
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning category plugins.json
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning category system_controller
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning category user_interface
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning into folder /data/plugins/
Jun 30 11:46:02 simonpi volumio[24452]: info: Scanning category audio_interface
Jun 30 11:46:02 simonpi volumio[24452]: info: Plugin folders cleanup completed
Jun 30 11:46:02 simonpi volumio[24452]: info: -------------------------------------------
Jun 30 11:46:02 simonpi volumio[24452]: info: ----- Core plugins startup ----
Jun 30 11:46:02 simonpi volumio[24452]: info: -------------------------------------------
Jun 30 11:46:02 simonpi volumio[24452]: info: Loading plugins from folder /volumio/app/plugins/
Jun 30 11:46:02 simonpi volumio[24452]: info: Adding plugin upnp to MyMusic Plugins
Jun 30 11:46:02 simonpi volumio[24452]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 30 11:46:02 simonpi volumio[24452]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 30 11:46:02 simonpi volumio[24452]: info: Loading plugins from folder /data/plugins/
Jun 30 11:46:02 simonpi volumio[24452]: info: Loading plugin "system"...
Jun 30 11:46:02 simonpi volumio[24452]: info: Loading plugin "appearance"...
Jun 30 11:46:02 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:02 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 326.
Jun 30 11:46:02 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:02 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "network"...
Jun 30 11:46:03 simonpi volumio[24452]: info: Refreshing Cached IP Addresses
Jun 30 11:46:03 simonpi sudo[24480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:46:03 simonpi sudo[24480]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:03 simonpi sudo[24482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:46:03 simonpi sudo[24482]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:03 simonpi sudo[24482]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:03 simonpi sudo[24480]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "services"...
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "alsa_controller"...
Jun 30 11:46:03 simonpi sudo[24497]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 30 11:46:03 simonpi sudo[24497]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:03 simonpi volumio[24452]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device.
Jun 30 11:46:03 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "wizard"...
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "networkfs"...
Jun 30 11:46:03 simonpi volumio[24452]: info: Starting Udev Watcher for removable devices
Jun 30 11:46:03 simonpi volumio[24452]: info: Ignoring mount for partition: boot
Jun 30 11:46:03 simonpi volumio[24452]: info: Ignoring mount for partition: volumio
Jun 30 11:46:03 simonpi volumio[24452]: info: Ignoring mount for partition: volumio_data
Jun 30 11:46:03 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "volumio_command_line_client"...
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "upnp"...
Jun 30 11:46:03 simonpi volumio[24452]: info: [1751280363613] Starting Upmpd Daemon
Jun 30 11:46:03 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "my_music"...
Jun 30 11:46:03 simonpi volumio[24452]: info: Loading plugin "mpd"...
Jun 30 11:46:03 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:03] [connect] Successful connection
Jun 30 11:46:04 simonpi volumio[24452]: info: Plugin upnp_browser is not enabled
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "alarm-clock"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "airplay_emulation"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Starting Shairport Sync
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "last_100"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "webradio"...
Jun 30 11:46:04 simonpi sudo[24497]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "i2s_dacs"...
Jun 30 11:46:04 simonpi volumio[24452]: info: I2S DAC not set, start Auto-detection
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "volumiodiscovery"...
Jun 30 11:46:04 simonpi volumio[24452]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:04 simonpi volumio[24452]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:04 simonpi volumio[24452]: *** WARNING *** For more information see
Jun 30 11:46:04 simonpi node[24452]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:04 simonpi volumio[24452]: *** 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:46:04 simonpi volumio[24452]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:04 simonpi volumio[24452]: *** WARNING *** For more information see
Jun 30 11:46:04 simonpi node[24452]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:04 simonpi node[24452]: *** WARNING *** For more information see
Jun 30 11:46:04 simonpi node[24452]: *** 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:46:04 simonpi node[24452]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:04 simonpi node[24452]: *** WARNING *** For more information see
Jun 30 11:46:04 simonpi volumio[24452]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 30 11:46:04 simonpi volumio[24478]: Traceback (most recent call last):
Jun 30 11:46:04 simonpi volumio[24478]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:04 simonpi volumio[24478]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:04 simonpi volumio[24478]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:04 simonpi volumio[24452]: info: Discovery: Started advertising with name: SimonPi
Jun 30 11:46:04 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "outputs"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "albumart"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Plugin example_plugin is not enabled
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "inputs"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "updater_comm"...
Jun 30 11:46:04 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:04 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:04 simonpi volumio[24452]: info: Plugin mpdemulation is not enabled
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "rest_api"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "websocket"...
Jun 30 11:46:04 simonpi volumio[24452]: info: Starting Socket.io Server version 2.3.0
Jun 30 11:46:04 simonpi volumio[24452]: info: Loading plugin "fusiondsp"...
Jun 30 11:46:05 simonpi volumio[24452]: Forking 3 albumart workers
Jun 30 11:46:05 simonpi volumio[24452]: info: Applying required configuration parameters for plugin fusiondsp
Jun 30 11:46:05 simonpi volumio[24452]: info: Loading i18n strings for locale en
Jun 30 11:46:05 simonpi volumio[24452]: Updating browse sources language
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::initPlayerControls
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:05 simonpi volumio[24452]: Express server listening on port 3000
Jun 30 11:46:05 simonpi volumio[24452]: [Metrics] WebUI: 5s 609.54ms
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::resetVolumioState
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::getcurrentVolume
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:06 simonpi volumio[24452]: info: Volumio Network Manager: Network status updated: 2
Jun 30 11:46:06 simonpi volumio[24452]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:06 simonpi volumio[24452]: 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:46:06 simonpi volumio[24452]: Starting albumart workers
Jun 30 11:46:06 simonpi volumio[24452]: 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:46:06 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280363 101
Jun 30 11:46:06 simonpi volumio[24452]: Starting albumart workers
Jun 30 11:46:06 simonpi volumio[24452]: 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:46:06 simonpi volumio[24452]: 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:46:06 simonpi volumio[24452]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::pushState
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::updateTrackBlock
Jun 30 11:46:06 simonpi volumio[24452]: Starting albumart workers
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrackBlock
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:46:06 simonpi volumio[24452]: info: Discovery: Getting this device information
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:06 simonpi volumio[24452]: info: Reloading queue from file
Jun 30 11:46:06 simonpi volumio[24452]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::setRepeat null single undefined
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::pushState
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::setRandom null
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::pushState
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:06 simonpi volumio[24452]: info: Setting Device type: Raspberry PI
Jun 30 11:46:06 simonpi volumio[24452]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 30 11:46:06 simonpi volumio[24452]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120
Jun 30 11:46:06 simonpi volumio[24452]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 30 11:46:06 simonpi volumio[24452]: 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:46:06 simonpi volumio[24452]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreStateMachine::pushState
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 30 11:46:06 simonpi volumio[24452]: info: Completed loading Core Plugins
Jun 30 11:46:06 simonpi volumio[24452]: info: Preparing to generate the ALSA configuration file
Jun 30 11:46:06 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:06 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 327.
Jun 30 11:46:06 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:06 simonpi volumio[24452]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187
Jun 30 11:46:06 simonpi volumio[24452]: info: Discovery: Found device SimonPi
Jun 30 11:46:06 simonpi volumio[24452]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:06 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:06 simonpi volumio[24452]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:46:06 simonpi volumio[24452]: info: Reading ALSA contributions from plugins.
Jun 30 11:46:06 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:06 simonpi volumio[24452]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:46:06 simonpi volumio[24452]: info: Output device has changed, restarting MPD
Jun 30 11:46:07 simonpi volumio[24452]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:07 simonpi sudo[24551]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:07 simonpi sudo[24551]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:07 simonpi sudo[24551]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:07 simonpi sudo[24553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:07 simonpi sudo[24553]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:07 simonpi systemd[1]: Stopping Music Player Daemon...
Jun 30 11:46:07 simonpi volumio[24452]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:07 simonpi volumio[24452]: info: ___________ START PLUGINS ___________
Jun 30 11:46:07 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:07 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:07 simonpi volumio[24452]: info: ControllerMpd::onStart: Initializing MPD
Jun 30 11:46:07 simonpi volumio[24452]: info: Creating MPD Configuration file
Jun 30 11:46:07 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:07 simonpi sudo[24570]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:07 simonpi sudo[24570]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:07 simonpi sudo[24570]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:07 simonpi volumio[24452]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:07 simonpi sudo[24568]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:07 simonpi sudo[24568]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:07 simonpi sudo[24584]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:07 simonpi sudo[24568]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:07 simonpi sudo[24584]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:07 simonpi volumio[24452]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:07 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:07 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:46:07 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:07 simonpi volumio[24452]: info: [1751280367614] CoreMusicLibrary::Adding element Last_100
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:07 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:46:07 simonpi volumio[24452]: info: [1751280367629] CoreMusicLibrary::Adding element Webradio
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:07 simonpi volumio[24452]: info: Initializing BBC Radios
Jun 30 11:46:07 simonpi volumio[24452]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:07 simonpi volumio[24452]: info: Loading i18n strings for locale en
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jun 30 11:46:07 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:07 simonpi volumio[24452]: info: FusionDsp - mixtype--------------------- undefined
Jun 30 11:46:07 simonpi volumio[24452]: info: Volumio Calling Home
Jun 30 11:46:07 simonpi sudo[24599]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:07 simonpi sudo[24599]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:07 simonpi sudo[24599]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:07 simonpi volumio[24452]: info: Preparing to generate the ALSA configuration file
Jun 30 11:46:08 simonpi volumio[24452]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:46:08 simonpi volumio[24452]: info: Reading ALSA contributions from plugins.
Jun 30 11:46:08 simonpi volumio[24452]: info: MPD Permissions set
Jun 30 11:46:08 simonpi volumio[24452]: info: MPD Permissions set
Jun 30 11:46:08 simonpi volumio[24452]: 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:46:08 simonpi volumio[24452]: info: Volumio called home
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: Starting Shairport Sync
Jun 30 11:46:08 simonpi volumio[24452]: info: Starting Shairport Sync
Jun 30 11:46:08 simonpi sudo[24624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:08 simonpi sudo[24624]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:08 simonpi volumio[24452]: info: Starting Shairport Sync
Jun 30 11:46:08 simonpi sudo[24626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:08 simonpi sudo[24626]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:08 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:08 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:08 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:08 simonpi sudo[24630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:08 simonpi sudo[24630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:08 simonpi volumio[24452]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:08 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:08 simonpi sudo[24626]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:08 simonpi volumio[24452]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:46:08 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:08 simonpi volumio[24452]: info: Output device has changed, restarting MPD
Jun 30 11:46:08 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:08 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:08 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:08 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:08 simonpi sudo[24630]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:08 simonpi sudo[24624]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:08 simonpi volumio[24452]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:08 simonpi sudo[24635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:08 simonpi sudo[24635]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:08 simonpi sudo[24635]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:08 simonpi sudo[24637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:08 simonpi sudo[24637]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:08 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:08 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:08 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:08 simonpi volumio[24452]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:08 simonpi volumio[24452]: info: Shairport-Sync Started
Jun 30 11:46:08 simonpi volumio[24452]: Error adding Membership: Error: addMembership EINVAL
Jun 30 11:46:08 simonpi volumio[24452]: info: MPD Permissions set
Jun 30 11:46:08 simonpi volumio[24452]: info: Shairport-Sync Started
Jun 30 11:46:08 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:08 simonpi volumio[24452]: info: Shairport-Sync Started
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:08 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:08 simonpi volumio[24549]: Traceback (most recent call last):
Jun 30 11:46:08 simonpi volumio[24549]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:08 simonpi volumio[24549]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:08 simonpi volumio[24549]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:08 simonpi volumio[24452]: info: Starting Shairport Sync
Jun 30 11:46:08 simonpi sudo[24652]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:08 simonpi sudo[24652]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:08 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:08 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:08 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:08 simonpi sudo[24645]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:08 simonpi sudo[24645]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:09 simonpi sudo[24645]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:09 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:09 simonpi sudo[24652]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:09 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:09 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:09 simonpi volumio[24452]: info: Shairport-Sync Started
Jun 30 11:46:09 simonpi volumio[24452]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:46:09 simonpi volumio[24452]: 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:46:09 simonpi volumio[24452]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:46:09 simonpi volumio[24452]: info: camilladsp service started and running in background, instance 1
Jun 30 11:46:09 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:09 simonpi volumio[24452]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:46:09 simonpi volumio[24452]: 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:46:09 simonpi volumio[24452]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:46:09 simonpi volumio[24452]: info: FusionDsp loaded
Jun 30 11:46:09 simonpi volumio[24452]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:09 simonpi sudo[24669]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Jun 30 11:46:09 simonpi sudo[24669]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:09 simonpi volumio[24452]: info: FusionDsp - Reporting Fusion DSP Enabled
Jun 30 11:46:09 simonpi volumio[24452]: info: Adding Signal Path Element [object Object]
Jun 30 11:46:09 simonpi volumio[24452]: info: Adding fusiondspeq DSP Signal Path Element
Jun 30 11:46:09 simonpi volumio[24452]: info: FusionDsp - ---- installed callbackRead
Jun 30 11:46:09 simonpi volumio[24452]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:09 simonpi volumio[24452]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Jun 30 11:46:09 simonpi volumio[24452]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Jun 30 11:46:09 simonpi volumio[24452]: at onErrorNT (internal/child_process.js:465:16)
Jun 30 11:46:09 simonpi volumio[24452]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Jun 30 11:46:09 simonpi volumio[24452]: errno: -2,
Jun 30 11:46:09 simonpi volumio[24452]: code: 'ENOENT',
Jun 30 11:46:09 simonpi volumio[24452]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:46:09 simonpi volumio[24452]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:46:09 simonpi volumio[24452]: spawnargs: [
Jun 30 11:46:09 simonpi volumio[24452]: '-p',
Jun 30 11:46:09 simonpi volumio[24452]: 9876,
Jun 30 11:46:09 simonpi volumio[24452]: '-o',
Jun 30 11:46:09 simonpi volumio[24452]: '/tmp/camilladsp.log',
Jun 30 11:46:09 simonpi volumio[24452]: '-l',
Jun 30 11:46:09 simonpi volumio[24452]: 'warn',
Jun 30 11:46:09 simonpi volumio[24452]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Jun 30 11:46:09 simonpi volumio[24452]: ]
Jun 30 11:46:09 simonpi volumio[24452]: }
Jun 30 11:46:09 simonpi volumio[24452]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:10 simonpi sudo[24681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:45
Jun 30 11:46:10 simonpi sudo[24681]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:10 simonpi mpd[24656]: Jun 30 11:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 30 11:46:10 simonpi systemd[1]: Started Music Player Daemon.
Jun 30 11:46:10 simonpi sudo[24553]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:10 simonpi sudo[24584]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:10 simonpi sudo[24637]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:10 simonpi sudo[24681]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:10 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:10] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 30 11:46:10 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:10 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:10] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 30 11:46:10 simonpi sudo[24669]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:10 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 30 11:46:10 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:11 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:11 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 30 11:46:11 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 94.
Jun 30 11:46:11 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:11 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 328.
Jun 30 11:46:11 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:11 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:11 simonpi systemd[1]: Stopped Volumio Backend Module.
Jun 30 11:46:11 simonpi systemd[1]: Started Volumio Backend Module.
Jun 30 11:46:11 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:11 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:12 simonpi volumio[24693]: Traceback (most recent call last):
Jun 30 11:46:12 simonpi volumio[24693]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:12 simonpi volumio[24693]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:12 simonpi volumio[24693]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:12 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:12 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:13 simonpi volumio[24694]: info: -------------------------------------------
Jun 30 11:46:13 simonpi volumio[24694]: info: ----- Volumio3 ----
Jun 30 11:46:13 simonpi volumio[24694]: info: -------------------------------------------
Jun 30 11:46:13 simonpi volumio[24694]: info: ----- System startup ----
Jun 30 11:46:13 simonpi volumio[24694]: info: -------------------------------------------
Jun 30 11:46:14 simonpi volumio[24694]: info: MYVOLUMIO Environment detected
Jun 30 11:46:14 simonpi volumio[24694]: info: Plugin folders cleanup
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning into folder /volumio/app/plugins/
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning category audio_interface
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning category miscellanea
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning category music_service
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning category plugins.json
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning category system_controller
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning category user_interface
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning into folder /data/plugins/
Jun 30 11:46:14 simonpi volumio[24694]: info: Scanning category audio_interface
Jun 30 11:46:14 simonpi volumio[24694]: info: Plugin folders cleanup completed
Jun 30 11:46:14 simonpi volumio[24694]: info: -------------------------------------------
Jun 30 11:46:14 simonpi volumio[24694]: info: ----- Core plugins startup ----
Jun 30 11:46:14 simonpi volumio[24694]: info: -------------------------------------------
Jun 30 11:46:14 simonpi volumio[24694]: info: Loading plugins from folder /volumio/app/plugins/
Jun 30 11:46:14 simonpi volumio[24694]: info: Adding plugin upnp to MyMusic Plugins
Jun 30 11:46:14 simonpi volumio[24694]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 30 11:46:14 simonpi volumio[24694]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 30 11:46:14 simonpi volumio[24694]: info: Loading plugins from folder /data/plugins/
Jun 30 11:46:14 simonpi volumio[24694]: info: Loading plugin "system"...
Jun 30 11:46:14 simonpi volumio[24694]: info: Loading plugin "appearance"...
Jun 30 11:46:15 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:15 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 329.
Jun 30 11:46:15 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:15 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "network"...
Jun 30 11:46:15 simonpi volumio[24694]: info: Refreshing Cached IP Addresses
Jun 30 11:46:15 simonpi sudo[24725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:46:15 simonpi sudo[24725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:15 simonpi sudo[24727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:46:15 simonpi sudo[24727]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:15 simonpi sudo[24727]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:15 simonpi sudo[24725]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "services"...
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "alsa_controller"...
Jun 30 11:46:15 simonpi sudo[24738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 30 11:46:15 simonpi sudo[24738]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:15 simonpi volumio[24694]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device.
Jun 30 11:46:15 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "wizard"...
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "networkfs"...
Jun 30 11:46:15 simonpi volumio[24694]: info: Starting Udev Watcher for removable devices
Jun 30 11:46:15 simonpi volumio[24694]: info: Ignoring mount for partition: boot
Jun 30 11:46:15 simonpi volumio[24694]: info: Ignoring mount for partition: volumio
Jun 30 11:46:15 simonpi volumio[24694]: info: Ignoring mount for partition: volumio_data
Jun 30 11:46:15 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "volumio_command_line_client"...
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "upnp"...
Jun 30 11:46:15 simonpi volumio[24694]: info: [1751280375837] Starting Upmpd Daemon
Jun 30 11:46:15 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "my_music"...
Jun 30 11:46:15 simonpi volumio[24694]: info: Loading plugin "mpd"...
Jun 30 11:46:15 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:15] [connect] Successful connection
Jun 30 11:46:16 simonpi volumio[24694]: info: Plugin upnp_browser is not enabled
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "alarm-clock"...
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "airplay_emulation"...
Jun 30 11:46:16 simonpi volumio[24694]: info: Starting Shairport Sync
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "last_100"...
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "webradio"...
Jun 30 11:46:16 simonpi sudo[24738]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "i2s_dacs"...
Jun 30 11:46:16 simonpi volumio[24694]: info: I2S DAC not set, start Auto-detection
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "volumiodiscovery"...
Jun 30 11:46:16 simonpi volumio[24694]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:16 simonpi volumio[24694]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:16 simonpi volumio[24694]: *** WARNING *** For more information see
Jun 30 11:46:16 simonpi node[24694]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:16 simonpi volumio[24694]: *** 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:46:16 simonpi volumio[24694]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:16 simonpi volumio[24694]: *** WARNING *** For more information see
Jun 30 11:46:16 simonpi node[24694]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:16 simonpi node[24694]: *** WARNING *** For more information see
Jun 30 11:46:16 simonpi node[24694]: *** 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:46:16 simonpi node[24694]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:16 simonpi node[24694]: *** WARNING *** For more information see
Jun 30 11:46:16 simonpi volumio[24694]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 30 11:46:16 simonpi volumio[24694]: info: Discovery: Started advertising with name: SimonPi
Jun 30 11:46:16 simonpi volumio[24723]: Traceback (most recent call last):
Jun 30 11:46:16 simonpi volumio[24723]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:16 simonpi volumio[24723]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:16 simonpi volumio[24723]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:16 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "outputs"...
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "albumart"...
Jun 30 11:46:16 simonpi volumio[24694]: info: Plugin example_plugin is not enabled
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "inputs"...
Jun 30 11:46:16 simonpi volumio[24694]: info: Loading plugin "updater_comm"...
Jun 30 11:46:16 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:16 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:17 simonpi volumio[24694]: info: Plugin mpdemulation is not enabled
Jun 30 11:46:17 simonpi volumio[24694]: info: Loading plugin "rest_api"...
Jun 30 11:46:17 simonpi volumio[24694]: info: Loading plugin "websocket"...
Jun 30 11:46:17 simonpi volumio[24694]: info: Starting Socket.io Server version 2.3.0
Jun 30 11:46:17 simonpi volumio[24694]: info: Loading plugin "fusiondsp"...
Jun 30 11:46:17 simonpi volumio[24694]: Forking 3 albumart workers
Jun 30 11:46:17 simonpi volumio[24694]: info: Applying required configuration parameters for plugin fusiondsp
Jun 30 11:46:17 simonpi volumio[24694]: info: Loading i18n strings for locale en
Jun 30 11:46:17 simonpi volumio[24694]: Updating browse sources language
Jun 30 11:46:17 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::initPlayerControls
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: Express server listening on port 3000
Jun 30 11:46:18 simonpi volumio[24694]: [Metrics] WebUI: 5s 621.58ms
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::resetVolumioState
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::getcurrentVolume
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:18 simonpi volumio[24694]: info: Volumio Network Manager: Network status updated: 2
Jun 30 11:46:18 simonpi volumio[24694]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:18 simonpi volumio[24694]: Starting albumart workers
Jun 30 11:46:18 simonpi volumio[24694]: 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:46:18 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280375 101
Jun 30 11:46:18 simonpi volumio[24694]: 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: 2
Jun 30 11:46:18 simonpi volumio[24694]: Starting albumart workers
Jun 30 11:46:18 simonpi volumio[24694]: 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:46:18 simonpi volumio[24694]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::pushState
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::updateTrackBlock
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrackBlock
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:18 simonpi volumio[24694]: Starting albumart workers
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:46:18 simonpi volumio[24694]: info: Discovery: Getting this device information
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:18 simonpi volumio[24694]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:18 simonpi volumio[24694]: info: Reloading queue from file
Jun 30 11:46:18 simonpi volumio[24694]: info: Setting Device type: Raspberry PI
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::setRepeat null single undefined
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::pushState
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::setRandom null
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::pushState
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:18 simonpi volumio[24694]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 30 11:46:18 simonpi volumio[24694]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120
Jun 30 11:46:18 simonpi volumio[24694]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 30 11:46:18 simonpi volumio[24694]: 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:46:18 simonpi volumio[24694]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreStateMachine::pushState
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 30 11:46:18 simonpi volumio[24694]: info: Completed loading Core Plugins
Jun 30 11:46:18 simonpi volumio[24694]: info: Preparing to generate the ALSA configuration file
Jun 30 11:46:18 simonpi volumio[24694]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:46:18 simonpi volumio[24694]: info: Reading ALSA contributions from plugins.
Jun 30 11:46:18 simonpi volumio[24694]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187
Jun 30 11:46:18 simonpi volumio[24694]: info: Discovery: Found device SimonPi
Jun 30 11:46:18 simonpi volumio[24694]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:18 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:19 simonpi volumio[24694]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:46:19 simonpi volumio[24694]: info: Output device has changed, restarting MPD
Jun 30 11:46:19 simonpi sudo[24795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:19 simonpi sudo[24795]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:19 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:19 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 330.
Jun 30 11:46:19 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:19 simonpi sudo[24795]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:19 simonpi volumio[24694]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:19 simonpi sudo[24799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:19 simonpi sudo[24799]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:19 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:19 simonpi systemd[1]: Stopping Music Player Daemon...
Jun 30 11:46:19 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:19 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:19 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:19 simonpi volumio[24694]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:19 simonpi volumio[24694]: info: ___________ START PLUGINS ___________
Jun 30 11:46:19 simonpi volumio[24694]: info: ControllerMpd::onStart: Initializing MPD
Jun 30 11:46:19 simonpi volumio[24694]: info: Creating MPD Configuration file
Jun 30 11:46:19 simonpi sudo[24806]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:19 simonpi sudo[24806]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:19 simonpi sudo[24806]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:19 simonpi sudo[24804]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:19 simonpi sudo[24804]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:19 simonpi sudo[24804]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:19 simonpi sudo[24810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:19 simonpi sudo[24810]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:19 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:19 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:19 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:19 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:19 simonpi volumio[24694]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:19 simonpi sudo[24816]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:19 simonpi sudo[24816]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:19 simonpi sudo[24816]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:19 simonpi volumio[24694]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:46:19 simonpi volumio[24694]: info: [1751280379777] CoreMusicLibrary::Adding element Last_100
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:46:19 simonpi volumio[24694]: info: [1751280379796] CoreMusicLibrary::Adding element Webradio
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:19 simonpi volumio[24694]: info: Initializing BBC Radios
Jun 30 11:46:19 simonpi volumio[24694]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:19 simonpi volumio[24694]: info: Loading i18n strings for locale en
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jun 30 11:46:19 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:19 simonpi volumio[24694]: info: FusionDsp - mixtype--------------------- undefined
Jun 30 11:46:19 simonpi volumio[24694]: info: Volumio Calling Home
Jun 30 11:46:20 simonpi volumio[24694]: info: Preparing to generate the ALSA configuration file
Jun 30 11:46:20 simonpi volumio[24694]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:46:20 simonpi volumio[24694]: info: Reading ALSA contributions from plugins.
Jun 30 11:46:20 simonpi volumio[24694]: info: MPD Permissions set
Jun 30 11:46:20 simonpi volumio[24694]: info: MPD Permissions set
Jun 30 11:46:20 simonpi volumio[24694]: 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:46:20 simonpi volumio[24694]: info: Volumio called home
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: Starting Shairport Sync
Jun 30 11:46:20 simonpi volumio[24694]: info: Starting Shairport Sync
Jun 30 11:46:20 simonpi volumio[24694]: info: Starting Shairport Sync
Jun 30 11:46:20 simonpi sudo[24868]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:20 simonpi sudo[24868]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:20 simonpi sudo[24870]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:20 simonpi sudo[24870]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:20 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:20 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:20 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:20 simonpi sudo[24874]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:20 simonpi sudo[24874]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:20 simonpi volumio[24694]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:20 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:20 simonpi sudo[24868]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:20 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:20 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:20 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:20 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:20 simonpi volumio[24694]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:46:20 simonpi volumio[24694]: info: Output device has changed, restarting MPD
Jun 30 11:46:20 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:20 simonpi sudo[24874]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:20 simonpi sudo[24870]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:20 simonpi volumio[24694]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:20 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:20 simonpi sudo[24881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:20 simonpi sudo[24881]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:20 simonpi sudo[24882]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:20 simonpi sudo[24882]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:20 simonpi sudo[24881]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:21 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:21 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:21 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:21 simonpi volumio[24694]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:21 simonpi volumio[24694]: info: Shairport-Sync Started
Jun 30 11:46:21 simonpi volumio[24694]: Error adding Membership: Error: addMembership EINVAL
Jun 30 11:46:21 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:21 simonpi volumio[24694]: info: MPD Permissions set
Jun 30 11:46:21 simonpi volumio[24694]: info: Shairport-Sync Started
Jun 30 11:46:21 simonpi volumio[24694]: info: Shairport-Sync Started
Jun 30 11:46:21 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:21 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:21 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:21 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:21 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:21 simonpi volumio[24798]: Traceback (most recent call last):
Jun 30 11:46:21 simonpi volumio[24798]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:21 simonpi volumio[24798]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:21 simonpi volumio[24798]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:21 simonpi volumio[24694]: info: Starting Shairport Sync
Jun 30 11:46:21 simonpi sudo[24897]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:21 simonpi sudo[24897]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:21 simonpi sudo[24890]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:21 simonpi sudo[24890]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:21 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:21 simonpi sudo[24890]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:21 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:21 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:21 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:21 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:21 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:21 simonpi sudo[24897]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:21 simonpi volumio[24694]: info: Shairport-Sync Started
Jun 30 11:46:21 simonpi volumio[24694]: 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: 6
Jun 30 11:46:21 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 30 11:46:22 simonpi volumio[24694]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:46:22 simonpi volumio[24694]: 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:46:22 simonpi volumio[24694]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:46:22 simonpi volumio[24694]: info: camilladsp service started and running in background, instance 1
Jun 30 11:46:22 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:22 simonpi volumio[24694]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:46:22 simonpi volumio[24694]: 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:46:22 simonpi volumio[24694]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:46:22 simonpi volumio[24694]: info: FusionDsp loaded
Jun 30 11:46:22 simonpi volumio[24694]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:22 simonpi sudo[24914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Jun 30 11:46:22 simonpi sudo[24914]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:22 simonpi volumio[24694]: info: FusionDsp - Reporting Fusion DSP Enabled
Jun 30 11:46:22 simonpi volumio[24694]: info: Adding Signal Path Element [object Object]
Jun 30 11:46:22 simonpi volumio[24694]: info: Adding fusiondspeq DSP Signal Path Element
Jun 30 11:46:22 simonpi volumio[24694]: info: FusionDsp - ---- installed callbackRead
Jun 30 11:46:22 simonpi volumio[24694]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:22 simonpi volumio[24694]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Jun 30 11:46:22 simonpi volumio[24694]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Jun 30 11:46:22 simonpi volumio[24694]: at onErrorNT (internal/child_process.js:465:16)
Jun 30 11:46:22 simonpi volumio[24694]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Jun 30 11:46:22 simonpi volumio[24694]: errno: -2,
Jun 30 11:46:22 simonpi volumio[24694]: code: 'ENOENT',
Jun 30 11:46:22 simonpi volumio[24694]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:46:22 simonpi volumio[24694]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:46:22 simonpi volumio[24694]: spawnargs: [
Jun 30 11:46:22 simonpi volumio[24694]: '-p',
Jun 30 11:46:22 simonpi volumio[24694]: 9876,
Jun 30 11:46:22 simonpi volumio[24694]: '-o',
Jun 30 11:46:22 simonpi volumio[24694]: '/tmp/camilladsp.log',
Jun 30 11:46:22 simonpi volumio[24694]: '-l',
Jun 30 11:46:22 simonpi volumio[24694]: 'warn',
Jun 30 11:46:22 simonpi volumio[24694]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Jun 30 11:46:22 simonpi volumio[24694]: ]
Jun 30 11:46:22 simonpi volumio[24694]: }
Jun 30 11:46:22 simonpi volumio[24694]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:22 simonpi sudo[24925]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:45
Jun 30 11:46:22 simonpi sudo[24925]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:23 simonpi mpd[24900]: Jun 30 11:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 30 11:46:23 simonpi systemd[1]: Started Music Player Daemon.
Jun 30 11:46:23 simonpi sudo[24882]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:23 simonpi sudo[24799]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:23 simonpi sudo[24925]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:23 simonpi sudo[24810]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:23 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:23] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 30 11:46:23 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:23] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 30 11:46:23 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:23 simonpi sudo[24914]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:23 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 30 11:46:23 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:23 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:23 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 30 11:46:23 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 95.
Jun 30 11:46:23 simonpi systemd[1]: Stopped Volumio Backend Module.
Jun 30 11:46:23 simonpi systemd[1]: Started Volumio Backend Module.
Jun 30 11:46:23 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:23 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:23 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 331.
Jun 30 11:46:23 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:23 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:23 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:25 simonpi volumio[24939]: Traceback (most recent call last):
Jun 30 11:46:25 simonpi volumio[24939]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:25 simonpi volumio[24939]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:25 simonpi volumio[24939]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:25 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:25 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:25 simonpi volumio[24937]: info: -------------------------------------------
Jun 30 11:46:25 simonpi volumio[24937]: info: ----- Volumio3 ----
Jun 30 11:46:25 simonpi volumio[24937]: info: -------------------------------------------
Jun 30 11:46:25 simonpi volumio[24937]: info: ----- System startup ----
Jun 30 11:46:25 simonpi volumio[24937]: info: -------------------------------------------
Jun 30 11:46:26 simonpi volumio[24937]: info: MYVOLUMIO Environment detected
Jun 30 11:46:26 simonpi volumio[24937]: info: Plugin folders cleanup
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning into folder /volumio/app/plugins/
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning category audio_interface
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning category miscellanea
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning category music_service
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning category plugins.json
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning category system_controller
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning category user_interface
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning into folder /data/plugins/
Jun 30 11:46:26 simonpi volumio[24937]: info: Scanning category audio_interface
Jun 30 11:46:26 simonpi volumio[24937]: info: Plugin folders cleanup completed
Jun 30 11:46:26 simonpi volumio[24937]: info: -------------------------------------------
Jun 30 11:46:26 simonpi volumio[24937]: info: ----- Core plugins startup ----
Jun 30 11:46:26 simonpi volumio[24937]: info: -------------------------------------------
Jun 30 11:46:26 simonpi volumio[24937]: info: Loading plugins from folder /volumio/app/plugins/
Jun 30 11:46:26 simonpi volumio[24937]: info: Adding plugin upnp to MyMusic Plugins
Jun 30 11:46:26 simonpi volumio[24937]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 30 11:46:26 simonpi volumio[24937]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 30 11:46:26 simonpi volumio[24937]: info: Loading plugins from folder /data/plugins/
Jun 30 11:46:26 simonpi volumio[24937]: info: Loading plugin "system"...
Jun 30 11:46:26 simonpi volumio[24937]: info: Loading plugin "appearance"...
Jun 30 11:46:27 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:27 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 332.
Jun 30 11:46:27 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:27 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:27 simonpi volumio[24937]: info: Loading plugin "network"...
Jun 30 11:46:27 simonpi volumio[24937]: info: Refreshing Cached IP Addresses
Jun 30 11:46:27 simonpi sudo[25005]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:46:27 simonpi sudo[25005]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:27 simonpi sudo[25007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:46:27 simonpi sudo[25007]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:27 simonpi sudo[25007]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:27 simonpi sudo[25005]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:27 simonpi volumio[24937]: info: Loading plugin "services"...
Jun 30 11:46:27 simonpi volumio[24937]: info: Loading plugin "alsa_controller"...
Jun 30 11:46:27 simonpi sudo[25018]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 30 11:46:27 simonpi sudo[25018]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:28 simonpi volumio[24937]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device.
Jun 30 11:46:28 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "wizard"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "networkfs"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Starting Udev Watcher for removable devices
Jun 30 11:46:28 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:28] [connect] Successful connection
Jun 30 11:46:28 simonpi volumio[24937]: info: Ignoring mount for partition: boot
Jun 30 11:46:28 simonpi volumio[24937]: info: Ignoring mount for partition: volumio
Jun 30 11:46:28 simonpi volumio[24937]: info: Ignoring mount for partition: volumio_data
Jun 30 11:46:28 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "volumio_command_line_client"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "upnp"...
Jun 30 11:46:28 simonpi volumio[24937]: info: [1751280388156] Starting Upmpd Daemon
Jun 30 11:46:28 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "my_music"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "mpd"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Plugin upnp_browser is not enabled
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "alarm-clock"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "airplay_emulation"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Starting Shairport Sync
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "last_100"...
Jun 30 11:46:28 simonpi volumio[24937]: info: Loading plugin "webradio"...
Jun 30 11:46:28 simonpi sudo[25018]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "i2s_dacs"...
Jun 30 11:46:29 simonpi volumio[24937]: info: I2S DAC not set, start Auto-detection
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "volumiodiscovery"...
Jun 30 11:46:29 simonpi volumio[25003]: Traceback (most recent call last):
Jun 30 11:46:29 simonpi volumio[25003]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:29 simonpi volumio[25003]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:29 simonpi volumio[25003]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:29 simonpi volumio[24937]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:29 simonpi volumio[24937]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:29 simonpi volumio[24937]: *** WARNING *** For more information see
Jun 30 11:46:29 simonpi node[24937]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:29 simonpi volumio[24937]: *** 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:46:29 simonpi volumio[24937]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:29 simonpi volumio[24937]: *** WARNING *** For more information see
Jun 30 11:46:29 simonpi node[24937]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:29 simonpi node[24937]: *** WARNING *** For more information see
Jun 30 11:46:29 simonpi node[24937]: *** 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:46:29 simonpi node[24937]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:29 simonpi node[24937]: *** WARNING *** For more information see
Jun 30 11:46:29 simonpi volumio[24937]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 30 11:46:29 simonpi volumio[24937]: info: Discovery: Started advertising with name: SimonPi
Jun 30 11:46:29 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "outputs"...
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "albumart"...
Jun 30 11:46:29 simonpi volumio[24937]: info: Plugin example_plugin is not enabled
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "inputs"...
Jun 30 11:46:29 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:29 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "updater_comm"...
Jun 30 11:46:29 simonpi volumio[24937]: info: Plugin mpdemulation is not enabled
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "rest_api"...
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "websocket"...
Jun 30 11:46:29 simonpi volumio[24937]: info: Starting Socket.io Server version 2.3.0
Jun 30 11:46:29 simonpi volumio[24937]: info: Loading plugin "fusiondsp"...
Jun 30 11:46:29 simonpi volumio[24937]: Forking 3 albumart workers
Jun 30 11:46:29 simonpi volumio[24937]: info: Applying required configuration parameters for plugin fusiondsp
Jun 30 11:46:30 simonpi volumio[24937]: info: Loading i18n strings for locale en
Jun 30 11:46:30 simonpi volumio[24937]: Updating browse sources language
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::initPlayerControls
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: Express server listening on port 3000
Jun 30 11:46:30 simonpi volumio[24937]: [Metrics] WebUI: 5s 582.09ms
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreStateMachine::resetVolumioState
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreStateMachine::getcurrentVolume
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:30 simonpi volumio[24937]: info: Volumio Network Manager: Network status updated: 2
Jun 30 11:46:30 simonpi volumio[24937]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:30 simonpi volumio[24937]: 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:46:30 simonpi volumio[24937]: Starting albumart workers
Jun 30 11:46:30 simonpi volumio[24937]: 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:46:30 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280388 101
Jun 30 11:46:30 simonpi volumio[24937]: 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:46:30 simonpi volumio[24937]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreStateMachine::pushState
Jun 30 11:46:30 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreStateMachine::updateTrackBlock
Jun 30 11:46:30 simonpi volumio[24937]: info: CorePlayQueue::getTrackBlock
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:30 simonpi volumio[24937]: Starting albumart workers
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:46:30 simonpi volumio[24937]: info: Discovery: Getting this device information
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:30 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:30 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:31 simonpi volumio[24937]: info: Reloading queue from file
Jun 30 11:46:31 simonpi volumio[24937]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:31 simonpi volumio[24937]: Starting albumart workers
Jun 30 11:46:31 simonpi volumio[24937]: info: Setting Device type: Raspberry PI
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreStateMachine::setRepeat null single undefined
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreStateMachine::pushState
Jun 30 11:46:31 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreStateMachine::setRandom null
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreStateMachine::pushState
Jun 30 11:46:31 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:31 simonpi volumio[24937]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreStateMachine::pushState
Jun 30 11:46:31 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:31 simonpi volumio[24937]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 30 11:46:31 simonpi volumio[24937]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120
Jun 30 11:46:31 simonpi volumio[24937]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 30 11:46:31 simonpi volumio[24937]: 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:46:31 simonpi volumio[24937]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:31 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 30 11:46:31 simonpi volumio[24937]: info: Completed loading Core Plugins
Jun 30 11:46:31 simonpi volumio[24937]: info: Preparing to generate the ALSA configuration file
Jun 30 11:46:31 simonpi volumio[24937]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187
Jun 30 11:46:31 simonpi volumio[24937]: info: Discovery: Found device SimonPi
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:31 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:31 simonpi volumio[24937]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:46:31 simonpi volumio[24937]: info: Reading ALSA contributions from plugins.
Jun 30 11:46:31 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:31 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 333.
Jun 30 11:46:31 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:31 simonpi volumio[24937]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:46:31 simonpi volumio[24937]: info: Output device has changed, restarting MPD
Jun 30 11:46:31 simonpi volumio[24937]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:31 simonpi sudo[25076]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:31 simonpi sudo[25078]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:31 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:31 simonpi sudo[25078]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:31 simonpi sudo[25076]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:31 simonpi sudo[25076]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:31 simonpi systemd[1]: Stopping Music Player Daemon...
Jun 30 11:46:31 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:31 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:31 simonpi volumio[24937]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:31 simonpi volumio[24937]: info: ___________ START PLUGINS ___________
Jun 30 11:46:31 simonpi volumio[24937]: info: ControllerMpd::onStart: Initializing MPD
Jun 30 11:46:31 simonpi volumio[24937]: info: Creating MPD Configuration file
Jun 30 11:46:31 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:31 simonpi sudo[25086]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:31 simonpi sudo[25086]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:31 simonpi sudo[25086]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:31 simonpi sudo[25088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:31 simonpi sudo[25088]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:31 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 30 11:46:31 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:31 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:31 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:31 simonpi volumio[24937]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:31 simonpi sudo[25092]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:31 simonpi sudo[25092]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:31 simonpi sudo[25092]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:31 simonpi volumio[24937]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:46:31 simonpi volumio[24937]: info: [1751280391947] CoreMusicLibrary::Adding element Last_100
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:46:31 simonpi volumio[24937]: info: [1751280391980] CoreMusicLibrary::Adding element Webradio
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:31 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:31 simonpi volumio[24937]: info: Initializing BBC Radios
Jun 30 11:46:32 simonpi volumio[24937]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: Loading i18n strings for locale en
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: FusionDsp - mixtype--------------------- undefined
Jun 30 11:46:32 simonpi volumio[24937]: info: Volumio Calling Home
Jun 30 11:46:32 simonpi volumio[24937]: info: Preparing to generate the ALSA configuration file
Jun 30 11:46:32 simonpi volumio[24937]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:46:32 simonpi volumio[24937]: info: Reading ALSA contributions from plugins.
Jun 30 11:46:32 simonpi volumio[24937]: 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:46:32 simonpi volumio[24937]: info: MPD Permissions set
Jun 30 11:46:32 simonpi volumio[24937]: info: MPD Permissions set
Jun 30 11:46:32 simonpi volumio[24937]: 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:46:32 simonpi volumio[24937]: info: Volumio called home
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:32 simonpi volumio[24937]: info: Starting Shairport Sync
Jun 30 11:46:32 simonpi volumio[24937]: info: Starting Shairport Sync
Jun 30 11:46:32 simonpi volumio[24937]: info: Starting Shairport Sync
Jun 30 11:46:32 simonpi sudo[25148]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:32 simonpi sudo[25148]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:33 simonpi sudo[25150]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:33 simonpi sudo[25150]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:33 simonpi sudo[25153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:33 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:33 simonpi sudo[25153]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:33 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:33 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:33 simonpi volumio[24937]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:33 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:33 simonpi sudo[25148]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:33 simonpi volumio[24937]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:46:33 simonpi volumio[24937]: info: Output device has changed, restarting MPD
Jun 30 11:46:33 simonpi volumio[24937]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:33 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:33 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:33 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:33 simonpi sudo[25160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:46:33 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:33 simonpi sudo[25160]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:33 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:33 simonpi sudo[25158]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:46:33 simonpi sudo[25158]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:33 simonpi sudo[25158]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:33 simonpi sudo[25153]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:33 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:46:33 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:46:33 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:46:33 simonpi sudo[25150]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:33 simonpi volumio[24937]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:46:33 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:46:33 simonpi volumio[24937]: info: MPD Permissions set
Jun 30 11:46:33 simonpi volumio[24937]: info: Shairport-Sync Started
Jun 30 11:46:33 simonpi volumio[24937]: Error adding Membership: Error: addMembership EINVAL
Jun 30 11:46:33 simonpi volumio[24937]: info: Shairport-Sync Started
Jun 30 11:46:33 simonpi volumio[24937]: info: Shairport-Sync Started
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[25074]: Traceback (most recent call last):
Jun 30 11:46:33 simonpi volumio[25074]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:33 simonpi volumio[25074]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:33 simonpi volumio[25074]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:33 simonpi volumio[24937]: info: Starting Shairport Sync
Jun 30 11:46:33 simonpi sudo[25176]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:46:33 simonpi sudo[25168]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:46:33 simonpi sudo[25176]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:33 simonpi sudo[25168]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:33 simonpi sudo[25168]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:33 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:33 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:33 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:46:33 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:46:33 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:33 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:46:33 simonpi sudo[25176]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:33 simonpi volumio[24937]: info: Shairport-Sync Started
Jun 30 11:46:34 simonpi volumio[24937]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:46:34 simonpi volumio[24937]: 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:46:34 simonpi volumio[24937]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:46:34 simonpi volumio[24937]: info: camilladsp service started and running in background, instance 1
Jun 30 11:46:34 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:34 simonpi volumio[24937]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:46:34 simonpi volumio[24937]: 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:46:34 simonpi volumio[24937]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:46:34 simonpi volumio[24937]: info: FusionDsp loaded
Jun 30 11:46:34 simonpi volumio[24937]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:34 simonpi sudo[25193]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Jun 30 11:46:34 simonpi sudo[25193]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:34 simonpi volumio[24937]: info: FusionDsp - Reporting Fusion DSP Enabled
Jun 30 11:46:34 simonpi volumio[24937]: info: Adding Signal Path Element [object Object]
Jun 30 11:46:34 simonpi volumio[24937]: info: Adding fusiondspeq DSP Signal Path Element
Jun 30 11:46:34 simonpi volumio[24937]: info: FusionDsp - ---- installed callbackRead
Jun 30 11:46:34 simonpi volumio[24937]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:34 simonpi volumio[24937]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Jun 30 11:46:34 simonpi volumio[24937]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Jun 30 11:46:34 simonpi volumio[24937]: at onErrorNT (internal/child_process.js:465:16)
Jun 30 11:46:34 simonpi volumio[24937]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Jun 30 11:46:34 simonpi volumio[24937]: errno: -2,
Jun 30 11:46:34 simonpi volumio[24937]: code: 'ENOENT',
Jun 30 11:46:34 simonpi volumio[24937]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:46:34 simonpi volumio[24937]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:46:34 simonpi volumio[24937]: spawnargs: [
Jun 30 11:46:34 simonpi volumio[24937]: '-p',
Jun 30 11:46:34 simonpi volumio[24937]: 9876,
Jun 30 11:46:34 simonpi volumio[24937]: '-o',
Jun 30 11:46:34 simonpi volumio[24937]: '/tmp/camilladsp.log',
Jun 30 11:46:34 simonpi volumio[24937]: '-l',
Jun 30 11:46:34 simonpi volumio[24937]: 'warn',
Jun 30 11:46:34 simonpi volumio[24937]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Jun 30 11:46:34 simonpi volumio[24937]: ]
Jun 30 11:46:34 simonpi volumio[24937]: }
Jun 30 11:46:34 simonpi volumio[24937]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:35 simonpi sudo[25204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:45
Jun 30 11:46:35 simonpi sudo[25204]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:35 simonpi sudo[25204]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:35 simonpi mpd[25179]: Jun 30 11:46 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 30 11:46:35 simonpi systemd[1]: Started Music Player Daemon.
Jun 30 11:46:35 simonpi sudo[25088]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:35 simonpi sudo[25160]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:35 simonpi sudo[25078]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:35 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:35] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 30 11:46:35 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:35] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 30 11:46:35 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:35 simonpi sudo[25193]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:35 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 30 11:46:35 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:35 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:35 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 30 11:46:35 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 96.
Jun 30 11:46:35 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:35 simonpi systemd[1]: Stopped Volumio Backend Module.
Jun 30 11:46:35 simonpi systemd[1]: Started Volumio Backend Module.
Jun 30 11:46:35 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:35 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:35 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 334.
Jun 30 11:46:35 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:35 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:37 simonpi volumio[25230]: Traceback (most recent call last):
Jun 30 11:46:37 simonpi volumio[25230]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:37 simonpi volumio[25230]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:37 simonpi volumio[25230]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:37 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:37 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:37 simonpi volumio[25218]: info: -------------------------------------------
Jun 30 11:46:37 simonpi volumio[25218]: info: ----- Volumio3 ----
Jun 30 11:46:37 simonpi volumio[25218]: info: -------------------------------------------
Jun 30 11:46:37 simonpi volumio[25218]: info: ----- System startup ----
Jun 30 11:46:37 simonpi volumio[25218]: info: -------------------------------------------
Jun 30 11:46:38 simonpi volumio[25218]: info: MYVOLUMIO Environment detected
Jun 30 11:46:38 simonpi volumio[25218]: info: Plugin folders cleanup
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning into folder /volumio/app/plugins/
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning category audio_interface
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning category miscellanea
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning category music_service
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning category plugins.json
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning category system_controller
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning category user_interface
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning into folder /data/plugins/
Jun 30 11:46:38 simonpi volumio[25218]: info: Scanning category audio_interface
Jun 30 11:46:38 simonpi volumio[25218]: info: Plugin folders cleanup completed
Jun 30 11:46:38 simonpi volumio[25218]: info: -------------------------------------------
Jun 30 11:46:38 simonpi volumio[25218]: info: ----- Core plugins startup ----
Jun 30 11:46:38 simonpi volumio[25218]: info: -------------------------------------------
Jun 30 11:46:38 simonpi volumio[25218]: info: Loading plugins from folder /volumio/app/plugins/
Jun 30 11:46:38 simonpi volumio[25218]: info: Adding plugin upnp to MyMusic Plugins
Jun 30 11:46:38 simonpi volumio[25218]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 30 11:46:38 simonpi volumio[25218]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 30 11:46:38 simonpi volumio[25218]: info: Loading plugins from folder /data/plugins/
Jun 30 11:46:38 simonpi volumio[25218]: info: Loading plugin "system"...
Jun 30 11:46:38 simonpi volumio[25218]: info: Loading plugin "appearance"...
Jun 30 11:46:39 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:39 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 335.
Jun 30 11:46:39 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:39 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "network"...
Jun 30 11:46:40 simonpi volumio[25218]: info: Refreshing Cached IP Addresses
Jun 30 11:46:40 simonpi sudo[25246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:46:40 simonpi sudo[25246]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:40 simonpi sudo[25248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:46:40 simonpi sudo[25248]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:40 simonpi sudo[25246]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:40 simonpi sudo[25248]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "services"...
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "alsa_controller"...
Jun 30 11:46:40 simonpi sudo[25259]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 30 11:46:40 simonpi sudo[25259]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:40 simonpi volumio[25218]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device.
Jun 30 11:46:40 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "wizard"...
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "networkfs"...
Jun 30 11:46:40 simonpi volumio[25218]: info: Starting Udev Watcher for removable devices
Jun 30 11:46:40 simonpi volumio[25218]: info: Ignoring mount for partition: boot
Jun 30 11:46:40 simonpi volumio[25218]: info: Ignoring mount for partition: volumio
Jun 30 11:46:40 simonpi volumio[25218]: info: Ignoring mount for partition: volumio_data
Jun 30 11:46:40 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "volumio_command_line_client"...
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "upnp"...
Jun 30 11:46:40 simonpi volumio[25218]: info: [1751280400300] Starting Upmpd Daemon
Jun 30 11:46:40 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "my_music"...
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "mpd"...
Jun 30 11:46:40 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:40] [connect] Successful connection
Jun 30 11:46:40 simonpi volumio[25218]: info: Plugin upnp_browser is not enabled
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "alarm-clock"...
Jun 30 11:46:40 simonpi volumio[25218]: info: Loading plugin "airplay_emulation"...
Jun 30 11:46:41 simonpi volumio[25218]: info: Starting Shairport Sync
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "last_100"...
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "webradio"...
Jun 30 11:46:41 simonpi sudo[25259]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "i2s_dacs"...
Jun 30 11:46:41 simonpi volumio[25218]: info: I2S DAC not set, start Auto-detection
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "volumiodiscovery"...
Jun 30 11:46:41 simonpi volumio[25218]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:41 simonpi volumio[25218]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:41 simonpi volumio[25218]: *** WARNING *** For more information see
Jun 30 11:46:41 simonpi node[25218]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:46:41 simonpi volumio[25218]: *** 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:46:41 simonpi volumio[25218]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:41 simonpi volumio[25218]: *** WARNING *** For more information see
Jun 30 11:46:41 simonpi node[25218]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:41 simonpi node[25218]: *** WARNING *** For more information see
Jun 30 11:46:41 simonpi node[25218]: *** 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:46:41 simonpi node[25218]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:46:41 simonpi node[25218]: *** WARNING *** For more information see
Jun 30 11:46:41 simonpi volumio[25218]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 30 11:46:41 simonpi volumio[25218]: info: Discovery: Started advertising with name: SimonPi
Jun 30 11:46:41 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "outputs"...
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "albumart"...
Jun 30 11:46:41 simonpi volumio[25218]: info: Plugin example_plugin is not enabled
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "inputs"...
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "updater_comm"...
Jun 30 11:46:41 simonpi volumio[25244]: Traceback (most recent call last):
Jun 30 11:46:41 simonpi volumio[25244]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:41 simonpi volumio[25244]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:41 simonpi volumio[25244]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:41 simonpi volumio[25218]: info: Plugin mpdemulation is not enabled
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "rest_api"...
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "websocket"...
Jun 30 11:46:41 simonpi volumio[25218]: info: Starting Socket.io Server version 2.3.0
Jun 30 11:46:41 simonpi volumio[25218]: info: Loading plugin "fusiondsp"...
Jun 30 11:46:41 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:41 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:41 simonpi volumio[25218]: Forking 3 albumart workers
Jun 30 11:46:42 simonpi volumio[25218]: info: Applying required configuration parameters for plugin fusiondsp
Jun 30 11:46:42 simonpi volumio[25218]: info: Loading i18n strings for locale en
Jun 30 11:46:42 simonpi volumio[25218]: Updating browse sources language
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::initPlayerControls
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: Express server listening on port 3000
Jun 30 11:46:42 simonpi volumio[25218]: [Metrics] WebUI: 5s 609.14ms
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreStateMachine::resetVolumioState
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreStateMachine::getcurrentVolume
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:42 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:46:42 simonpi volumio[25218]: info: Volumio Network Manager: Network status updated: 2
Jun 30 11:46:42 simonpi volumio[25218]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:42 simonpi volumio[25218]: 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:46:43 simonpi volumio[25218]: 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:46:43 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:43] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280400 101
Jun 30 11:46:43 simonpi volumio[25218]: 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:46:43 simonpi volumio[25218]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreStateMachine::pushState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:43 simonpi volumio[25218]: Starting albumart workers
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreStateMachine::updateTrackBlock
Jun 30 11:46:43 simonpi volumio[25218]: Starting albumart workers
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrackBlock
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:46:43 simonpi volumio[25218]: info: Discovery: Getting this device information
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:43 simonpi volumio[25218]: Starting albumart workers
Jun 30 11:46:43 simonpi volumio[25218]: 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:46:43 simonpi volumio[25218]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:46:43 simonpi volumio[25218]: info: Reloading queue from file
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreStateMachine::setRepeat null single undefined
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreStateMachine::pushState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreStateMachine::setRandom null
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreStateMachine::pushState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:43 simonpi volumio[25218]: info: Setting Device type: Raspberry PI
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 30 11:46:43 simonpi volumio[25218]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreStateMachine::pushState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioPushState
Jun 30 11:46:43 simonpi volumio[25218]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 30 11:46:43 simonpi volumio[25218]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120
Jun 30 11:46:43 simonpi volumio[25218]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 30 11:46:43 simonpi volumio[25218]: info: Received Get System Info
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:46:43 simonpi volumio[25218]: info: Discovery: Getting this device information
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: Listing playlists
Jun 30 11:46:43 simonpi volumio[25218]: 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:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 30 11:46:43 simonpi volumio[25218]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187
Jun 30 11:46:43 simonpi volumio[25218]: info: Discovery: Found device SimonPi
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::volumioGetState
Jun 30 11:46:43 simonpi volumio[25218]: info: CorePlayQueue::getTrack 0
Jun 30 11:46:43 simonpi volumio[25218]: info: Completed loading Core Plugins
Jun 30 11:46:43 simonpi volumio[25218]: info: Preparing to generate the ALSA configuration file
Jun 30 11:46:43 simonpi volumio[25218]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:46:43 simonpi volumio[25218]: info: Reading ALSA contributions from plugins.
Jun 30 11:46:43 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:43 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 336.
Jun 30 11:46:43 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:43 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:46:44 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:44 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:44 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:45 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:45 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:45 simonpi volumio[25320]: Traceback (most recent call last):
Jun 30 11:46:45 simonpi volumio[25320]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:45 simonpi volumio[25320]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:45 simonpi volumio[25320]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:45 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:45 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:45 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:45 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:46 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:46 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:46 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:47 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:47 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:47 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:47 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:47 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 337.
Jun 30 11:46:47 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:47 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:47 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:48 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:48 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:48 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:48 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:48 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:49 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:49 simonpi volumio[25341]: Traceback (most recent call last):
Jun 30 11:46:49 simonpi volumio[25341]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:49 simonpi volumio[25341]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:49 simonpi volumio[25341]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:49 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:49 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:49 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:49 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:49 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:50 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:50 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:50 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:50 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:51 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:51 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:51 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:51 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:51 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:51 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 338.
Jun 30 11:46:51 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:51 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:51 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:52 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:52 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:52 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:52 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:53 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:53 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:53 simonpi volumio[25356]: Traceback (most recent call last):
Jun 30 11:46:53 simonpi volumio[25356]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:53 simonpi volumio[25356]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:53 simonpi volumio[25356]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:53 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:53 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:53 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:53 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp -
Jun 30 11:46:54 simonpi sudo[25358]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:46:54 simonpi sudo[25358]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:54 simonpi sudo[25358]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:54 simonpi sudo[25363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:46:54 simonpi sudo[25363]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:54 simonpi sudo[25363]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:54 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:55 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 339.
Jun 30 11:46:55 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:55 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: FusionDsp - undefined
Jun 30 11:46:56 simonpi volumio[25218]: info: Starting Uninstall of plugin audio_interface - fusiondsp
Jun 30 11:46:56 simonpi volumio[25218]: info: Uninstalling plugin fusiondsp
Jun 30 11:46:56 simonpi volumio[25218]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:56 simonpi volumio[25218]: TypeError: Cannot read property 'off' of undefined
Jun 30 11:46:56 simonpi volumio[25218]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15)
Jun 30 11:46:56 simonpi volumio[25218]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Jun 30 11:46:56 simonpi volumio[25218]: at PluginManager.unInstallPlugin (/volumio/app/pluginmanager.js:1449:10)
Jun 30 11:46:56 simonpi volumio[25218]: at CoreCommandRouter.unInstallPlugin (/volumio/app/index.js:1484:22)
Jun 30 11:46:56 simonpi volumio[25218]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1260:45)
Jun 30 11:46:56 simonpi volumio[25218]: at Socket.emit (events.js:315:20)
Jun 30 11:46:56 simonpi volumio[25218]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jun 30 11:46:56 simonpi volumio[25218]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jun 30 11:46:56 simonpi volumio[25218]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:46:57 simonpi volumio[25368]: Traceback (most recent call last):
Jun 30 11:46:57 simonpi volumio[25368]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:46:57 simonpi volumio[25368]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:46:57 simonpi volumio[25368]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:46:57 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:57 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:46:57 simonpi sudo[25378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:45
Jun 30 11:46:57 simonpi sudo[25378]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:46:57 simonpi sudo[25378]: pam_unix(sudo:session): session closed for user root
Jun 30 11:46:58 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:58] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 30 11:46:58 simonpi volumio-remote-updater[524]: [2025-06-30 11:46:58] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 30 11:46:58 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:46:58 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 30 11:46:58 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:58 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:58 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 30 11:46:58 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 97.
Jun 30 11:46:58 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:46:58 simonpi systemd[1]: Stopped Volumio Backend Module.
Jun 30 11:46:58 simonpi systemd[1]: Started Volumio Backend Module.
Jun 30 11:46:58 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:46:59 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:46:59 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 340.
Jun 30 11:46:59 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:46:59 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:01 simonpi volumio[25392]: info: -------------------------------------------
Jun 30 11:47:01 simonpi volumio[25392]: info: ----- Volumio3 ----
Jun 30 11:47:01 simonpi volumio[25392]: info: -------------------------------------------
Jun 30 11:47:01 simonpi volumio[25392]: info: ----- System startup ----
Jun 30 11:47:01 simonpi volumio[25392]: info: -------------------------------------------
Jun 30 11:47:01 simonpi volumio[25404]: Traceback (most recent call last):
Jun 30 11:47:01 simonpi volumio[25404]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:01 simonpi volumio[25404]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:01 simonpi volumio[25404]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:01 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:01 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:01 simonpi volumio[25392]: info: MYVOLUMIO Environment detected
Jun 30 11:47:02 simonpi volumio[25392]: info: Plugin folders cleanup
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning into folder /volumio/app/plugins/
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning category audio_interface
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning category miscellanea
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning category music_service
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning category plugins.json
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning category system_controller
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning category user_interface
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning into folder /data/plugins/
Jun 30 11:47:02 simonpi volumio[25392]: info: Scanning category audio_interface
Jun 30 11:47:02 simonpi volumio[25392]: info: Plugin folders cleanup completed
Jun 30 11:47:02 simonpi volumio[25392]: info: -------------------------------------------
Jun 30 11:47:02 simonpi volumio[25392]: info: ----- Core plugins startup ----
Jun 30 11:47:02 simonpi volumio[25392]: info: -------------------------------------------
Jun 30 11:47:02 simonpi volumio[25392]: info: Loading plugins from folder /volumio/app/plugins/
Jun 30 11:47:02 simonpi volumio[25392]: info: Adding plugin upnp to MyMusic Plugins
Jun 30 11:47:02 simonpi volumio[25392]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 30 11:47:02 simonpi volumio[25392]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 30 11:47:02 simonpi volumio[25392]: info: Loading plugins from folder /data/plugins/
Jun 30 11:47:02 simonpi volumio[25392]: info: Loading plugin "system"...
Jun 30 11:47:02 simonpi volumio[25392]: info: Loading plugin "appearance"...
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "network"...
Jun 30 11:47:03 simonpi volumio[25392]: info: Refreshing Cached IP Addresses
Jun 30 11:47:03 simonpi sudo[25419]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:47:03 simonpi sudo[25419]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:03 simonpi sudo[25421]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:47:03 simonpi sudo[25421]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:03 simonpi sudo[25421]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "services"...
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "alsa_controller"...
Jun 30 11:47:03 simonpi sudo[25419]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:03 simonpi sudo[25431]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 30 11:47:03 simonpi sudo[25431]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:03 simonpi volumio[25392]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device.
Jun 30 11:47:03 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "wizard"...
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "networkfs"...
Jun 30 11:47:03 simonpi volumio-remote-updater[524]: [2025-06-30 11:47:03] [connect] Successful connection
Jun 30 11:47:03 simonpi volumio[25392]: info: Starting Udev Watcher for removable devices
Jun 30 11:47:03 simonpi volumio[25392]: info: Ignoring mount for partition: boot
Jun 30 11:47:03 simonpi volumio[25392]: info: Ignoring mount for partition: volumio
Jun 30 11:47:03 simonpi volumio[25392]: info: Ignoring mount for partition: volumio_data
Jun 30 11:47:03 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "volumio_command_line_client"...
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "upnp"...
Jun 30 11:47:03 simonpi volumio[25392]: info: [1751280423542] Starting Upmpd Daemon
Jun 30 11:47:03 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "my_music"...
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "mpd"...
Jun 30 11:47:03 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:03 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 341.
Jun 30 11:47:03 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:03 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:03 simonpi volumio[25392]: info: Plugin upnp_browser is not enabled
Jun 30 11:47:03 simonpi volumio[25392]: info: Loading plugin "alarm-clock"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "airplay_emulation"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Starting Shairport Sync
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "last_100"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "webradio"...
Jun 30 11:47:04 simonpi sudo[25431]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "i2s_dacs"...
Jun 30 11:47:04 simonpi volumio[25392]: info: I2S DAC not set, start Auto-detection
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "volumiodiscovery"...
Jun 30 11:47:04 simonpi volumio[25392]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:47:04 simonpi volumio[25392]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:04 simonpi volumio[25392]: *** WARNING *** For more information see
Jun 30 11:47:04 simonpi node[25392]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:47:04 simonpi volumio[25392]: *** 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:47:04 simonpi volumio[25392]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:04 simonpi volumio[25392]: *** WARNING *** For more information see
Jun 30 11:47:04 simonpi node[25392]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:04 simonpi node[25392]: *** WARNING *** For more information see
Jun 30 11:47:04 simonpi node[25392]: *** 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:47:04 simonpi node[25392]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:04 simonpi node[25392]: *** WARNING *** For more information see
Jun 30 11:47:04 simonpi volumio[25392]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 30 11:47:04 simonpi volumio[25392]: info: Discovery: Started advertising with name: SimonPi
Jun 30 11:47:04 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "outputs"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "albumart"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Plugin example_plugin is not enabled
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "inputs"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "updater_comm"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Plugin mpdemulation is not enabled
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "rest_api"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "websocket"...
Jun 30 11:47:04 simonpi volumio[25392]: info: Starting Socket.io Server version 2.3.0
Jun 30 11:47:04 simonpi volumio[25392]: info: Loading plugin "fusiondsp"...
Jun 30 11:47:05 simonpi volumio[25392]: Forking 3 albumart workers
Jun 30 11:47:05 simonpi volumio[25392]: info: Applying required configuration parameters for plugin fusiondsp
Jun 30 11:47:05 simonpi volumio[25446]: Traceback (most recent call last):
Jun 30 11:47:05 simonpi volumio[25446]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:05 simonpi volumio[25446]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:05 simonpi volumio[25446]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:05 simonpi volumio[25392]: info: Loading i18n strings for locale en
Jun 30 11:47:05 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:05 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:05 simonpi volumio[25392]: Updating browse sources language
Jun 30 11:47:05 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::initPlayerControls
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: Express server listening on port 3000
Jun 30 11:47:06 simonpi volumio[25392]: [Metrics] WebUI: 5s 854.95ms
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::resetVolumioState
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::getcurrentVolume
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:06 simonpi volumio[25392]: info: Volumio Network Manager: Network status updated: 2
Jun 30 11:47:06 simonpi volumio[25392]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:47:06 simonpi volumio[25392]: Starting albumart workers
Jun 30 11:47:06 simonpi volumio[25392]: 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:47:06 simonpi volumio[25392]: Starting albumart workers
Jun 30 11:47:06 simonpi volumio[25392]: 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:47:06 simonpi volumio-remote-updater[524]: [2025-06-30 11:47:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280423 101
Jun 30 11:47:06 simonpi volumio[25392]: 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:47:06 simonpi volumio[25392]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::pushState
Jun 30 11:47:06 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:06 simonpi volumio[25392]: Starting albumart workers
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::updateTrackBlock
Jun 30 11:47:06 simonpi volumio[25392]: info: CorePlayQueue::getTrackBlock
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:47:06 simonpi volumio[25392]: info: Discovery: Getting this device information
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:06 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:47:06 simonpi volumio[25392]: 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:47:06 simonpi volumio[25392]: info: Reloading queue from file
Jun 30 11:47:06 simonpi volumio[25392]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:47:06 simonpi volumio[25392]: info: Setting Device type: Raspberry PI
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::setRepeat null single undefined
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::pushState
Jun 30 11:47:06 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::setRandom null
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::pushState
Jun 30 11:47:06 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled
Jun 30 11:47:06 simonpi volumio[25392]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 30 11:47:06 simonpi volumio[25392]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120
Jun 30 11:47:06 simonpi volumio[25392]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 30 11:47:06 simonpi volumio[25392]: 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:47:06 simonpi volumio[25392]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreStateMachine::pushState
Jun 30 11:47:06 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:06 simonpi volumio[25392]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:07 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::volumioGetVisibleSources
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:07 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom
Jun 30 11:47:07 simonpi volumio[25392]: info: Received Get System Info
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:47:07 simonpi volumio[25392]: info: Discovery: Getting this device information
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:07 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:07 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:07 simonpi volumio[25392]: info: Listing playlists
Jun 30 11:47:07 simonpi volumio[25392]: info: Completed loading Core Plugins
Jun 30 11:47:07 simonpi volumio[25392]: info: Preparing to generate the ALSA configuration file
Jun 30 11:47:07 simonpi volumio[25392]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187
Jun 30 11:47:07 simonpi volumio[25392]: info: Discovery: Found device SimonPi
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:07 simonpi volumio[25392]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:07 simonpi volumio[25392]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:47:07 simonpi volumio[25392]: info: Reading ALSA contributions from plugins.
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: CoreCommandRouter::getUIConfigOnPlugin
Jun 30 11:47:07 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:07 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:08 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:08 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 342.
Jun 30 11:47:08 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:08 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:08 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:08 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:08 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:09 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:09 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:09 simonpi volumio[25514]: Traceback (most recent call last):
Jun 30 11:47:09 simonpi volumio[25514]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:09 simonpi volumio[25514]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:09 simonpi volumio[25514]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:09 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:09 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:09 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:10 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:10 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:10 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:10 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:11 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:11 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:11 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:11 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:12 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:12 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:12 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 343.
Jun 30 11:47:12 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:12 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:12 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:12 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:12 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:13 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:13 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:13 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:13 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:13 simonpi volumio[25515]: Traceback (most recent call last):
Jun 30 11:47:13 simonpi volumio[25515]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:13 simonpi volumio[25515]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:13 simonpi volumio[25515]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:13 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:13 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:13 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:14 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:14 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:14 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:14 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:15 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:15 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:15 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:15 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:16 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:16 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:16 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 344.
Jun 30 11:47:16 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:16 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:16 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:16 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:16 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:16 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:17 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:17 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:17 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:17 simonpi volumio[25533]: Traceback (most recent call last):
Jun 30 11:47:17 simonpi volumio[25533]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:17 simonpi volumio[25533]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:17 simonpi volumio[25533]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:17 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:17 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:17 simonpi volumio[25392]: info: FusionDsp -
Jun 30 11:47:18 simonpi sudo[25535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:47:18 simonpi sudo[25535]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:18 simonpi sudo[25535]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi sudo[25540]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:47:18 simonpi sudo[25540]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:18 simonpi sudo[25540]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:18 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:19 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:20 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 345.
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:20 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: info: FusionDsp - undefined
Jun 30 11:47:20 simonpi volumio[25392]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:47:20 simonpi volumio[25392]: TypeError: Cannot read property 'off' of undefined
Jun 30 11:47:20 simonpi volumio[25392]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15)
Jun 30 11:47:20 simonpi volumio[25392]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30)
Jun 30 11:47:20 simonpi volumio[25392]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8)
Jun 30 11:47:20 simonpi volumio[25392]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29)
Jun 30 11:47:20 simonpi volumio[25392]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47)
Jun 30 11:47:20 simonpi volumio[25392]: at Socket.emit (events.js:315:20)
Jun 30 11:47:20 simonpi volumio[25392]: at /volumio/node_modules/socket.io/lib/socket.js:528:12
Jun 30 11:47:20 simonpi volumio[25392]: at processTicksAndRejections (internal/process/task_queues.js:75:11)
Jun 30 11:47:20 simonpi volumio[25392]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:47:21 simonpi sudo[25552]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:46
Jun 30 11:47:21 simonpi sudo[25552]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:21 simonpi sudo[25552]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:21 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:21 simonpi volumio-remote-updater[524]: [2025-06-30 11:47:21] [error] handle_read_frame error: websocketpp.transport:7 (End of File)
Jun 30 11:47:21 simonpi volumio-remote-updater[524]: [2025-06-30 11:47:21] [disconnect] Disconnect close local:[1006,End of File] remote:[1006]
Jun 30 11:47:21 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'.
Jun 30 11:47:21 simonpi volumio[25542]: Traceback (most recent call last):
Jun 30 11:47:21 simonpi volumio[25542]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:21 simonpi volumio[25542]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:21 simonpi volumio[25542]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:21 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:47:22 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:47:22 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart.
Jun 30 11:47:22 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 98.
Jun 30 11:47:22 simonpi systemd[1]: Started dynamicswap service.
Jun 30 11:47:22 simonpi systemd[1]: Stopped Volumio Backend Module.
Jun 30 11:47:22 simonpi systemd[1]: Started Volumio Backend Module.
Jun 30 11:47:22 simonpi systemd[1]: dynamicswap.service: Succeeded.
Jun 30 11:47:22 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:22 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:24 simonpi volumio[25563]: info: -------------------------------------------
Jun 30 11:47:24 simonpi volumio[25563]: info: ----- Volumio3 ----
Jun 30 11:47:24 simonpi volumio[25563]: info: -------------------------------------------
Jun 30 11:47:24 simonpi volumio[25563]: info: ----- System startup ----
Jun 30 11:47:24 simonpi volumio[25563]: info: -------------------------------------------
Jun 30 11:47:24 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:24 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 346.
Jun 30 11:47:24 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:24 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:25 simonpi volumio[25563]: info: MYVOLUMIO Environment detected
Jun 30 11:47:25 simonpi volumio[25563]: info: Plugin folders cleanup
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning into folder /volumio/app/plugins/
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning category audio_interface
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning category miscellanea
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning category music_service
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning category plugins.json
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning category system_controller
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning category user_interface
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning into folder /data/plugins/
Jun 30 11:47:25 simonpi volumio[25563]: info: Scanning category audio_interface
Jun 30 11:47:25 simonpi volumio[25563]: info: Plugin folders cleanup completed
Jun 30 11:47:25 simonpi volumio[25563]: info: -------------------------------------------
Jun 30 11:47:25 simonpi volumio[25563]: info: ----- Core plugins startup ----
Jun 30 11:47:25 simonpi volumio[25563]: info: -------------------------------------------
Jun 30 11:47:25 simonpi volumio[25563]: info: Loading plugins from folder /volumio/app/plugins/
Jun 30 11:47:25 simonpi volumio[25563]: info: Adding plugin upnp to MyMusic Plugins
Jun 30 11:47:25 simonpi volumio[25563]: info: Adding plugin airplay_emulation to MyMusic Plugins
Jun 30 11:47:25 simonpi volumio[25563]: info: Adding plugin upnp_browser to MyMusic Plugins
Jun 30 11:47:25 simonpi volumio[25563]: info: Loading plugins from folder /data/plugins/
Jun 30 11:47:25 simonpi volumio[25563]: info: Loading plugin "system"...
Jun 30 11:47:25 simonpi volumio[25563]: info: Loading plugin "appearance"...
Jun 30 11:47:26 simonpi volumio[25583]: Traceback (most recent call last):
Jun 30 11:47:26 simonpi volumio[25583]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:26 simonpi volumio[25583]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:26 simonpi volumio[25583]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:26 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:26 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:26 simonpi volumio[25563]: info: Loading plugin "network"...
Jun 30 11:47:26 simonpi volumio[25563]: info: Refreshing Cached IP Addresses
Jun 30 11:47:26 simonpi sudo[25628]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Jun 30 11:47:26 simonpi sudo[25628]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:26 simonpi volumio-remote-updater[524]: [2025-06-30 11:47:26] [connect] Successful connection
Jun 30 11:47:26 simonpi sudo[25630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Jun 30 11:47:26 simonpi sudo[25630]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:26 simonpi sudo[25630]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:26 simonpi sudo[25628]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:26 simonpi volumio[25563]: info: Loading plugin "services"...
Jun 30 11:47:26 simonpi volumio[25563]: info: Loading plugin "alsa_controller"...
Jun 30 11:47:26 simonpi sudo[25645]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Jun 30 11:47:26 simonpi sudo[25645]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:27 simonpi volumio[25563]: warn: Unable to locate the audio output device Shanling UA4. Please configure a valid output device.
Jun 30 11:47:27 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "wizard"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "networkfs"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Starting Udev Watcher for removable devices
Jun 30 11:47:27 simonpi volumio[25563]: info: Ignoring mount for partition: boot
Jun 30 11:47:27 simonpi volumio[25563]: info: Ignoring mount for partition: volumio
Jun 30 11:47:27 simonpi volumio[25563]: info: Ignoring mount for partition: volumio_data
Jun 30 11:47:27 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "volumio_command_line_client"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "upnp"...
Jun 30 11:47:27 simonpi volumio[25563]: info: [1751280447162] Starting Upmpd Daemon
Jun 30 11:47:27 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "my_music"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "mpd"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Plugin upnp_browser is not enabled
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "alarm-clock"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "airplay_emulation"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Starting Shairport Sync
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "last_100"...
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "webradio"...
Jun 30 11:47:27 simonpi sudo[25645]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "i2s_dacs"...
Jun 30 11:47:27 simonpi volumio[25563]: info: I2S DAC not set, start Auto-detection
Jun 30 11:47:27 simonpi volumio[25563]: info: Loading plugin "volumiodiscovery"...
Jun 30 11:47:28 simonpi volumio[25563]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:47:28 simonpi volumio[25563]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:28 simonpi volumio[25563]: *** WARNING *** For more information see
Jun 30 11:47:28 simonpi node[25563]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Jun 30 11:47:28 simonpi volumio[25563]: *** 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:47:28 simonpi volumio[25563]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:28 simonpi volumio[25563]: *** WARNING *** For more information see
Jun 30 11:47:28 simonpi node[25563]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:28 simonpi node[25563]: *** WARNING *** For more information see
Jun 30 11:47:28 simonpi node[25563]: *** 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:47:28 simonpi node[25563]: *** WARNING *** Please fix your application to use the native API of Avahi!
Jun 30 11:47:28 simonpi node[25563]: *** WARNING *** For more information see
Jun 30 11:47:28 simonpi volumio[25563]: info: Applying required configuration parameters for plugin volumiodiscovery
Jun 30 11:47:28 simonpi volumio[25563]: info: Discovery: Started advertising with name: SimonPi
Jun 30 11:47:28 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Jun 30 11:47:28 simonpi volumio[25563]: info: Loading plugin "outputs"...
Jun 30 11:47:28 simonpi volumio[25563]: info: Loading plugin "albumart"...
Jun 30 11:47:28 simonpi volumio[25563]: info: Plugin example_plugin is not enabled
Jun 30 11:47:28 simonpi volumio[25563]: info: Loading plugin "inputs"...
Jun 30 11:47:28 simonpi volumio[25563]: info: Loading plugin "updater_comm"...
Jun 30 11:47:28 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:28 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 347.
Jun 30 11:47:28 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:28 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:28 simonpi volumio[25563]: info: Plugin mpdemulation is not enabled
Jun 30 11:47:28 simonpi volumio[25563]: info: Loading plugin "rest_api"...
Jun 30 11:47:28 simonpi volumio[25563]: info: Loading plugin "websocket"...
Jun 30 11:47:28 simonpi volumio[25563]: info: Starting Socket.io Server version 2.3.0
Jun 30 11:47:28 simonpi volumio[25563]: info: Loading plugin "fusiondsp"...
Jun 30 11:47:28 simonpi volumio[25563]: Forking 3 albumart workers
Jun 30 11:47:28 simonpi volumio[25563]: info: Applying required configuration parameters for plugin fusiondsp
Jun 30 11:47:29 simonpi volumio[25563]: info: Loading i18n strings for locale en
Jun 30 11:47:29 simonpi volumio[25563]: Updating browse sources language
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::initPlayerControls
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: Express server listening on port 3000
Jun 30 11:47:29 simonpi volumio[25563]: [Metrics] WebUI: 6s 266.38ms
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreStateMachine::resetVolumioState
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreStateMachine::getcurrentVolume
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:47:29 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:29 simonpi volumio[25563]: info: Volumio Network Manager: Network status updated: 2
Jun 30 11:47:30 simonpi volumio[25563]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:47:30 simonpi volumio[25563]: Starting albumart workers
Jun 30 11:47:30 simonpi volumio[25665]: Traceback (most recent call last):
Jun 30 11:47:30 simonpi volumio[25665]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:30 simonpi volumio[25665]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:30 simonpi volumio[25665]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:30 simonpi volumio[25563]: 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:47:30 simonpi volumio[25563]: Starting albumart workers
Jun 30 11:47:30 simonpi volumio[25563]: 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:47:30 simonpi volumio-remote-updater[524]: [2025-06-30 11:47:30] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751280446 101
Jun 30 11:47:30 simonpi volumio[25563]: 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:47:30 simonpi volumio[25563]: 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:47:30 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:30 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:30 simonpi volumio[25563]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreStateMachine::pushState
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreStateMachine::updateTrackBlock
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrackBlock
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioRetrievevolume
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Jun 30 11:47:30 simonpi volumio[25563]: info: Discovery: Getting this device information
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:47:30 simonpi volumio[25563]: Starting albumart workers
Jun 30 11:47:30 simonpi volumio[25563]: error: Cannot get ALSA Volume: Error: Alsa Mixer Error: Invalid card number.
Jun 30 11:47:30 simonpi volumio[25563]: info: Reloading queue from file
Jun 30 11:47:30 simonpi volumio[25563]: info: VolumeController:: Volume=undefined Mute =false
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreStateMachine::pushState
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreStateMachine::setRepeat null single undefined
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreStateMachine::pushState
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreStateMachine::setRandom null
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreStateMachine::pushState
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioPushState
Jun 30 11:47:30 simonpi volumio[25563]: info: Setting Device type: Raspberry PI
Jun 30 11:47:30 simonpi volumio[25563]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb
Jun 30 11:47:30 simonpi volumio[25563]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120
Jun 30 11:47:30 simonpi volumio[25563]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI
Jun 30 11:47:30 simonpi volumio[25563]: 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:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard
Jun 30 11:47:30 simonpi volumio[25563]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187
Jun 30 11:47:30 simonpi volumio[25563]: info: Discovery: Found device SimonPi
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:30 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:30 simonpi volumio[25563]: info: Completed loading Core Plugins
Jun 30 11:47:30 simonpi volumio[25563]: info: Preparing to generate the ALSA configuration file
Jun 30 11:47:30 simonpi volumio[25563]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:47:30 simonpi volumio[25563]: info: Reading ALSA contributions from plugins.
Jun 30 11:47:30 simonpi volumio[25563]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:47:30 simonpi volumio[25563]: info: Output device has changed, restarting MPD
Jun 30 11:47:30 simonpi volumio[25563]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:30 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:31 simonpi sudo[25701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:47:31 simonpi sudo[25701]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:31 simonpi sudo[25701]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:31 simonpi sudo[25710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:47:31 simonpi sudo[25710]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:31 simonpi systemd[1]: Stopping Music Player Daemon...
Jun 30 11:47:31 simonpi volumio[25563]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:47:31 simonpi volumio[25563]: info: ___________ START PLUGINS ___________
Jun 30 11:47:31 simonpi volumio[25563]: info: ControllerMpd::onStart: Initializing MPD
Jun 30 11:47:31 simonpi volumio[25563]: info: Creating MPD Configuration file
Jun 30 11:47:31 simonpi sudo[25725]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:31 simonpi sudo[25725]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:31 simonpi sudo[25725]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:31 simonpi sudo[25727]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:47:31 simonpi sudo[25727]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:31 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:47:31 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:47:31 simonpi volumio[25563]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:31 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:47:31 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM
Jun 30 11:47:31 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:47:31 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:47:31 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:47:31 simonpi volumio[25563]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:47:31 simonpi volumio[25563]: info: [1751280451363] CoreMusicLibrary::Adding element Last_100
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Jun 30 11:47:31 simonpi volumio[25563]: info: [1751280451374] CoreMusicLibrary::Adding element Webradio
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:47:31 simonpi volumio[25563]: info: Initializing BBC Radios
Jun 30 11:47:31 simonpi volumio[25563]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: Loading i18n strings for locale en
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: FusionDsp - mixtype--------------------- undefined
Jun 30 11:47:31 simonpi volumio[25563]: info: Volumio Calling Home
Jun 30 11:47:31 simonpi sudo[25737]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:47:31 simonpi sudo[25737]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:31 simonpi sudo[25737]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:31 simonpi volumio[25563]: info: Preparing to generate the ALSA configuration file
Jun 30 11:47:31 simonpi volumio[25563]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Jun 30 11:47:31 simonpi volumio[25563]: info: Reading ALSA contributions from plugins.
Jun 30 11:47:31 simonpi volumio[25563]: info: MPD Permissions set
Jun 30 11:47:31 simonpi volumio[25563]: info: MPD Permissions set
Jun 30 11:47:31 simonpi volumio[25563]: 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:47:31 simonpi volumio[25563]: info: Volumio called home
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:31 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: Starting Shairport Sync
Jun 30 11:47:32 simonpi volumio[25563]: info: Starting Shairport Sync
Jun 30 11:47:32 simonpi sudo[25770]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:47:32 simonpi volumio[25563]: info: Starting Shairport Sync
Jun 30 11:47:32 simonpi sudo[25770]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:32 simonpi sudo[25775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:47:32 simonpi sudo[25775]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:32 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:47:32 simonpi sudo[25772]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:47:32 simonpi sudo[25772]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::volumioGetState
Jun 30 11:47:32 simonpi volumio[25563]: info: CorePlayQueue::getTrack 0
Jun 30 11:47:32 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:47:32 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:47:32 simonpi volumio[25563]: info: Asound.conf file unchanged, so no further update is needed
Jun 30 11:47:32 simonpi volumio[25563]: info: Output device has changed, restarting MPD
Jun 30 11:47:32 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:47:32 simonpi sudo[25770]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:32 simonpi sudo[25772]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:32 simonpi volumio[25563]: info: Output device has changed, restarting Shairport Sync
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:32 simonpi sudo[25775]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:32 simonpi sudo[25782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Jun 30 11:47:32 simonpi sudo[25782]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:32 simonpi sudo[25780]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Jun 30 11:47:32 simonpi sudo[25780]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:32 simonpi sudo[25780]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:32 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Jun 30 11:47:32 simonpi systemd[1]: mpd.service: Succeeded.
Jun 30 11:47:32 simonpi systemd[1]: Stopped Music Player Daemon.
Jun 30 11:47:32 simonpi systemd[1]: Starting Music Player Daemon...
Jun 30 11:47:32 simonpi volumio[25563]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Jun 30 11:47:32 simonpi volumio[25563]: info: MPD Permissions set
Jun 30 11:47:32 simonpi volumio[25563]: info: Shairport-Sync Started
Jun 30 11:47:32 simonpi volumio[25563]: Error adding Membership: Error: addMembership EINVAL
Jun 30 11:47:32 simonpi volumio[25563]: info: Shairport-Sync Started
Jun 30 11:47:32 simonpi volumio[25563]: info: Shairport-Sync Started
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:32 simonpi volumio[25563]: info: Starting Shairport Sync
Jun 30 11:47:32 simonpi sudo[25789]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Jun 30 11:47:32 simonpi sudo[25789]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:32 simonpi sudo[25789]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:32 simonpi sudo[25797]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Jun 30 11:47:32 simonpi sudo[25797]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:32 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart.
Jun 30 11:47:32 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 348.
Jun 30 11:47:32 simonpi systemd[1]: Stopped FusionDsp Daemon.
Jun 30 11:47:32 simonpi systemd[1]: Started FusionDsp Daemon.
Jun 30 11:47:32 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Jun 30 11:47:32 simonpi systemd[1]: shairport-sync.service: Succeeded.
Jun 30 11:47:32 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:47:32 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Jun 30 11:47:32 simonpi sudo[25797]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:32 simonpi volumio[25563]: info: Shairport-Sync Started
Jun 30 11:47:33 simonpi volumio[25563]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:47:33 simonpi volumio[25563]: 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:47:33 simonpi volumio[25563]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists
Jun 30 11:47:33 simonpi volumio[25563]: info: camilladsp service started and running in background, instance 1
Jun 30 11:47:33 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Jun 30 11:47:33 simonpi volumio[25563]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:47:33 simonpi volumio[25563]: 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:47:33 simonpi volumio[25563]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Jun 30 11:47:33 simonpi volumio[25563]: info: FusionDsp loaded
Jun 30 11:47:33 simonpi volumio[25563]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Jun 30 11:47:33 simonpi sudo[25815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Jun 30 11:47:33 simonpi sudo[25815]: pam_unix(sudo:session): session opened for user root by (uid=0)
Jun 30 11:47:33 simonpi volumio[25563]: info: FusionDsp - Reporting Fusion DSP Enabled
Jun 30 11:47:33 simonpi volumio[25563]: info: Adding Signal Path Element [object Object]
Jun 30 11:47:33 simonpi volumio[25563]: info: Adding fusiondspeq DSP Signal Path Element
Jun 30 11:47:33 simonpi volumio[25563]: info: FusionDsp - ---- installed callbackRead
Jun 30 11:47:33 simonpi volumio[25563]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:47:33 simonpi sudo[25815]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:33 simonpi volumio[25563]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Jun 30 11:47:33 simonpi volumio[25563]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Jun 30 11:47:33 simonpi volumio[25563]: at onErrorNT (internal/child_process.js:465:16)
Jun 30 11:47:33 simonpi volumio[25563]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Jun 30 11:47:33 simonpi volumio[25563]: errno: -2,
Jun 30 11:47:33 simonpi volumio[25563]: code: 'ENOENT',
Jun 30 11:47:33 simonpi volumio[25563]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:47:33 simonpi volumio[25563]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Jun 30 11:47:33 simonpi volumio[25563]: spawnargs: [
Jun 30 11:47:33 simonpi volumio[25563]: '-p',
Jun 30 11:47:33 simonpi volumio[25563]: 9876,
Jun 30 11:47:33 simonpi volumio[25563]: '-o',
Jun 30 11:47:33 simonpi volumio[25563]: '/tmp/camilladsp.log',
Jun 30 11:47:33 simonpi volumio[25563]: '-l',
Jun 30 11:47:33 simonpi volumio[25563]: 'warn',
Jun 30 11:47:33 simonpi volumio[25563]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Jun 30 11:47:33 simonpi volumio[25563]: ]
Jun 30 11:47:33 simonpi volumio[25563]: }
Jun 30 11:47:33 simonpi volumio[25563]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Jun 30 11:47:34 simonpi volumio[25801]: Traceback (most recent call last):
Jun 30 11:47:34 simonpi volumio[25801]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in
Jun 30 11:47:34 simonpi volumio[25801]: from camilladsp_plot.validate_config import CamillaValidator
Jun 30 11:47:34 simonpi volumio[25801]: ModuleNotFoundError: No module named 'camilladsp_plot'
Jun 30 11:47:34 simonpi mpd[25799]: Jun 30 11:47 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Jun 30 11:47:34 simonpi systemd[1]: Started Music Player Daemon.
Jun 30 11:47:34 simonpi sudo[25710]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:34 simonpi sudo[25727]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:34 simonpi sudo[25782]: pam_unix(sudo:session): session closed for user root
Jun 30 11:47:34 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE
Jun 30 11:47:34 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
Jun 30 11:47:34 simonpi sudo[25828]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:46
Jun 30 11:47:34 simonpi sudo[25828]: 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"