-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Mon 2025-06-30 11:28:26 BST. -- Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::initPlayerControls Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: Express server listening on port 3000 Jun 30 11:27:00 simonpi volumio[4710]: [Metrics] WebUI: 5s 531.30ms Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::resetVolumioState Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::getcurrentVolume Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:00 simonpi volumio[4710]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:27:00 simonpi volumio[4710]: 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:27:00 simonpi volumio[4710]: 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:27:00 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:00] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751279217 101 Jun 30 11:27:00 simonpi volumio[4710]: 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:27:00 simonpi volumio[4710]: 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:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:00 simonpi volumio[4710]: info: Discovery: Getting this device information Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:00 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:00 simonpi volumio[4710]: Starting albumart workers Jun 30 11:27:00 simonpi volumio[4710]: info: Reloading queue from file Jun 30 11:27:00 simonpi volumio[4710]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:00 simonpi volumio[4710]: Starting albumart workers Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::pushState Jun 30 11:27:00 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::updateTrackBlock Jun 30 11:27:00 simonpi volumio[4710]: info: CorePlayQueue::getTrackBlock Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::pushState Jun 30 11:27:00 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:00 simonpi volumio[4710]: Starting albumart workers Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::setRandom null Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::pushState Jun 30 11:27:00 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:00 simonpi volumio[4710]: info: Setting Device type: Raspberry PI Jun 30 11:27:00 simonpi volumio[4710]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:27:00 simonpi volumio[4710]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:27:00 simonpi volumio[4710]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:27:00 simonpi volumio[4710]: 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:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:00 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:27:00 simonpi volumio[4710]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:00 simonpi volumio[4710]: info: CoreStateMachine::pushState Jun 30 11:27:00 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:00 simonpi volumio[4710]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:00 simonpi volumio[4710]: info: Completed loading Core Plugins Jun 30 11:27:00 simonpi volumio[4710]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:01 simonpi volumio[4710]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:27:01 simonpi volumio[4710]: info: Discovery: Found device SimonPi Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:01 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:01 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:01 simonpi volumio[4710]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:01 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 47. Jun 30 11:27:01 simonpi volumio[4710]: info: Reading ALSA contributions from plugins. Jun 30 11:27:01 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:01 simonpi volumio[4710]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:01 simonpi volumio[4710]: info: Output device has changed, restarting MPD Jun 30 11:27:01 simonpi volumio[4710]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:01 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:01 simonpi sudo[4811]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:01 simonpi sudo[4811]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:01 simonpi sudo[4813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:01 simonpi sudo[4813]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:01 simonpi sudo[4811]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:01 simonpi volumio[4710]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:01 simonpi volumio[4710]: info: ___________ START PLUGINS ___________ Jun 30 11:27:01 simonpi volumio[4710]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:27:01 simonpi volumio[4710]: info: Creating MPD Configuration file Jun 30 11:27:01 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:01 simonpi sudo[4820]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:01 simonpi sudo[4820]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:01 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:01 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:01 simonpi sudo[4820]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:01 simonpi sudo[4823]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:01 simonpi sudo[4823]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:01 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:01 simonpi volumio[4710]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:01 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:27:01 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:01 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:01 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:01 simonpi volumio[4710]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:01 simonpi volumio[4710]: info: [1751279221589] CoreMusicLibrary::Adding element Last_100 Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:01 simonpi volumio[4710]: info: [1751279221603] CoreMusicLibrary::Adding element Webradio Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:01 simonpi volumio[4710]: info: Initializing BBC Radios Jun 30 11:27:01 simonpi volumio[4710]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:01 simonpi sudo[4832]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:01 simonpi sudo[4832]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:01 simonpi sudo[4832]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:01 simonpi volumio[4710]: info: Loading i18n strings for locale en Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:27:01 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:01 simonpi volumio[4710]: info: FusionDsp - mixtype--------------------- Hardware Jun 30 11:27:01 simonpi volumio[4710]: info: Volumio Calling Home Jun 30 11:27:02 simonpi volumio[4710]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:02 simonpi volumio[4710]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:02 simonpi volumio[4710]: info: Reading ALSA contributions from plugins. Jun 30 11:27:02 simonpi volumio[4710]: info: MPD Permissions set Jun 30 11:27:02 simonpi volumio[4710]: info: MPD Permissions set Jun 30 11:27:02 simonpi volumio[4710]: info: Volumio called home Jun 30 11:27:02 simonpi volumio[4710]: 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:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: Starting Shairport Sync Jun 30 11:27:02 simonpi volumio[4710]: info: Starting Shairport Sync Jun 30 11:27:02 simonpi volumio[4710]: info: Starting Shairport Sync Jun 30 11:27:02 simonpi sudo[4881]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:02 simonpi sudo[4881]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:02 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:02 simonpi sudo[4883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:02 simonpi sudo[4883]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:02 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:02 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:02 simonpi sudo[4888]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:02 simonpi sudo[4888]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:02 simonpi volumio[4710]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:02 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:02 simonpi sudo[4881]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:02 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:02 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 30 11:27:02 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:02 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:02 simonpi volumio[4710]: info: Shairport-Sync Started Jun 30 11:27:02 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:02 simonpi volumio[4710]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:27:02 simonpi volumio[4710]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:02 simonpi volumio[4710]: info: Output device has changed, restarting MPD Jun 30 11:27:02 simonpi sudo[4888]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:02 simonpi sudo[4883]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:02 simonpi volumio[4710]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:02 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:03 simonpi sudo[4893]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:03 simonpi sudo[4893]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:03 simonpi sudo[4894]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:03 simonpi sudo[4894]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:03 simonpi sudo[4894]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:03 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:27:03 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:03 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:03 simonpi volumio[4710]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:03 simonpi volumio[4710]: info: MPD Permissions set Jun 30 11:27:03 simonpi volumio[4710]: info: Shairport-Sync Started Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: info: Starting Shairport Sync Jun 30 11:27:03 simonpi volumio[4809]: Traceback (most recent call last): Jun 30 11:27:03 simonpi volumio[4809]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:03 simonpi volumio[4809]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:03 simonpi volumio[4809]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:03 simonpi sudo[4909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:03 simonpi sudo[4909]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:03 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:03 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:03 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:03 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:03 simonpi sudo[4909]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:03 simonpi sudo[4902]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:03 simonpi sudo[4902]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:03 simonpi volumio[4710]: info: Shairport-Sync Started Jun 30 11:27:03 simonpi sudo[4902]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:03 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:03 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:03 simonpi volumio[4710]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:03 simonpi volumio[4710]: 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:27:03 simonpi volumio[4710]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:03 simonpi volumio[4710]: info: camilladsp service started and running in background, instance 1 Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:03 simonpi volumio[4710]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:03 simonpi volumio[4710]: 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:27:03 simonpi volumio[4710]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:03 simonpi volumio[4710]: info: FusionDsp loaded Jun 30 11:27:03 simonpi volumio[4710]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:03 simonpi sudo[4926]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:27:03 simonpi sudo[4926]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:03 simonpi volumio[4710]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:27:03 simonpi volumio[4710]: info: Adding Signal Path Element [object Object] Jun 30 11:27:03 simonpi volumio[4710]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:27:03 simonpi volumio[4710]: info: FusionDsp - ---- installed callbackRead Jun 30 11:27:04 simonpi volumio[4710]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:04 simonpi volumio[4710]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:27:04 simonpi volumio[4710]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:27:04 simonpi volumio[4710]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:27:04 simonpi volumio[4710]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jun 30 11:27:04 simonpi volumio[4710]: errno: -2, Jun 30 11:27:04 simonpi volumio[4710]: code: 'ENOENT', Jun 30 11:27:04 simonpi volumio[4710]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:04 simonpi volumio[4710]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:04 simonpi volumio[4710]: spawnargs: [ Jun 30 11:27:04 simonpi volumio[4710]: '-p', Jun 30 11:27:04 simonpi volumio[4710]: 9876, Jun 30 11:27:04 simonpi volumio[4710]: '-o', Jun 30 11:27:04 simonpi volumio[4710]: '/tmp/camilladsp.log', Jun 30 11:27:04 simonpi volumio[4710]: '-l', Jun 30 11:27:04 simonpi volumio[4710]: 'warn', Jun 30 11:27:04 simonpi volumio[4710]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:27:04 simonpi volumio[4710]: ] Jun 30 11:27:04 simonpi volumio[4710]: } Jun 30 11:27:04 simonpi volumio[4710]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:04 simonpi sudo[4937]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:26 Jun 30 11:27:04 simonpi sudo[4937]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:04 simonpi sudo[4937]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:05 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:05] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:27:05 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:05] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:27:05 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:05 simonpi sudo[4813]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:05 simonpi sudo[4823]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:05 simonpi sudo[4893]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:05 simonpi sudo[4926]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:05 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:27:05 simonpi mpd[4913]: Jun 30 11:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:27:05 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:05 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:27:05 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:05 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:27:05 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 16. Jun 30 11:27:05 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:05 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:27:05 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:27:05 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:05 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:05 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 48. Jun 30 11:27:05 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:05 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:07 simonpi volumio[4962]: Traceback (most recent call last): Jun 30 11:27:07 simonpi volumio[4962]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:07 simonpi volumio[4962]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:07 simonpi volumio[4962]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:07 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:07 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:07 simonpi volumio[4950]: info: ------------------------------------------- Jun 30 11:27:07 simonpi volumio[4950]: info: ----- Volumio3 ---- Jun 30 11:27:07 simonpi volumio[4950]: info: ------------------------------------------- Jun 30 11:27:07 simonpi volumio[4950]: info: ----- System startup ---- Jun 30 11:27:07 simonpi volumio[4950]: info: ------------------------------------------- Jun 30 11:27:08 simonpi volumio[4950]: info: MYVOLUMIO Environment detected Jun 30 11:27:08 simonpi volumio[4950]: info: Plugin folders cleanup Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning category audio_interface Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning category miscellanea Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning category music_service Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning category plugins.json Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning category system_controller Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning category user_interface Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning into folder /data/plugins/ Jun 30 11:27:08 simonpi volumio[4950]: info: Scanning category audio_interface Jun 30 11:27:08 simonpi volumio[4950]: info: Plugin folders cleanup completed Jun 30 11:27:08 simonpi volumio[4950]: info: ------------------------------------------- Jun 30 11:27:08 simonpi volumio[4950]: info: ----- Core plugins startup ---- Jun 30 11:27:08 simonpi volumio[4950]: info: ------------------------------------------- Jun 30 11:27:08 simonpi volumio[4950]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:27:08 simonpi volumio[4950]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:27:08 simonpi volumio[4950]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:27:08 simonpi volumio[4950]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:27:08 simonpi volumio[4950]: info: Loading plugins from folder /data/plugins/ Jun 30 11:27:08 simonpi volumio[4950]: info: Loading plugin "system"... Jun 30 11:27:08 simonpi volumio[4950]: info: Loading plugin "appearance"... Jun 30 11:27:09 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:09 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 49. Jun 30 11:27:09 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:09 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:09 simonpi volumio[4950]: info: Loading plugin "network"... Jun 30 11:27:09 simonpi volumio[4950]: info: Refreshing Cached IP Addresses Jun 30 11:27:09 simonpi sudo[4978]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:27:09 simonpi sudo[4978]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:09 simonpi sudo[4980]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:27:09 simonpi sudo[4980]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:09 simonpi volumio[4950]: info: Loading plugin "services"... Jun 30 11:27:09 simonpi sudo[4980]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:09 simonpi sudo[4978]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:09 simonpi volumio[4950]: info: Loading plugin "alsa_controller"... Jun 30 11:27:09 simonpi sudo[4990]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:27:09 simonpi sudo[4990]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:10 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:10] [connect] Successful connection Jun 30 11:27:10 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "wizard"... Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "networkfs"... Jun 30 11:27:10 simonpi volumio[4950]: info: Starting Udev Watcher for removable devices Jun 30 11:27:10 simonpi volumio[4950]: info: Ignoring mount for partition: boot Jun 30 11:27:10 simonpi volumio[4950]: info: Ignoring mount for partition: volumio Jun 30 11:27:10 simonpi volumio[4950]: info: Ignoring mount for partition: volumio_data Jun 30 11:27:10 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "upnp"... Jun 30 11:27:10 simonpi volumio[4950]: info: [1751279230179] Starting Upmpd Daemon Jun 30 11:27:10 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "my_music"... Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "mpd"... Jun 30 11:27:10 simonpi volumio[4950]: info: Plugin upnp_browser is not enabled Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "alarm-clock"... Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "airplay_emulation"... Jun 30 11:27:10 simonpi volumio[4950]: info: Starting Shairport Sync Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "last_100"... Jun 30 11:27:10 simonpi volumio[4950]: info: Loading plugin "webradio"... Jun 30 11:27:10 simonpi sudo[4990]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "i2s_dacs"... Jun 30 11:27:11 simonpi volumio[4950]: info: I2S DAC not set, start Auto-detection Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "volumiodiscovery"... Jun 30 11:27:11 simonpi volumio[4950]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:11 simonpi node[4950]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:11 simonpi volumio[4950]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:11 simonpi node[4950]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:11 simonpi volumio[4950]: *** WARNING *** For more information see Jun 30 11:27:11 simonpi node[4950]: *** WARNING *** For more information see Jun 30 11:27:11 simonpi volumio[4950]: *** 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:27:11 simonpi node[4950]: *** 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:27:11 simonpi volumio[4950]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:11 simonpi node[4950]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:11 simonpi volumio[4950]: *** WARNING *** For more information see Jun 30 11:27:11 simonpi volumio[4950]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:27:11 simonpi node[4950]: *** WARNING *** For more information see Jun 30 11:27:11 simonpi volumio[4950]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:27:11 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "outputs"... Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "albumart"... Jun 30 11:27:11 simonpi volumio[4950]: info: Plugin example_plugin is not enabled Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "inputs"... Jun 30 11:27:11 simonpi volumio[4976]: Traceback (most recent call last): Jun 30 11:27:11 simonpi volumio[4976]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:11 simonpi volumio[4976]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:11 simonpi volumio[4976]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "updater_comm"... Jun 30 11:27:11 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:11 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:11 simonpi volumio[4950]: info: Plugin mpdemulation is not enabled Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "rest_api"... Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "websocket"... Jun 30 11:27:11 simonpi volumio[4950]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:27:11 simonpi volumio[4950]: info: Loading plugin "fusiondsp"... Jun 30 11:27:11 simonpi volumio[4950]: Forking 3 albumart workers Jun 30 11:27:12 simonpi volumio[4950]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:27:12 simonpi volumio[4950]: info: Loading i18n strings for locale en Jun 30 11:27:12 simonpi volumio[4950]: Updating browse sources language Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::initPlayerControls Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: Express server listening on port 3000 Jun 30 11:27:12 simonpi volumio[4950]: [Metrics] WebUI: 5s 920.76ms Jun 30 11:27:12 simonpi volumio[4950]: info: CoreStateMachine::resetVolumioState Jun 30 11:27:12 simonpi volumio[4950]: info: CoreStateMachine::getcurrentVolume Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:12 simonpi volumio[4950]: Starting albumart workers Jun 30 11:27:12 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:12 simonpi volumio[4950]: Starting albumart workers Jun 30 11:27:12 simonpi volumio[4950]: Starting albumart workers Jun 30 11:27:12 simonpi volumio[4950]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:27:13 simonpi volumio[4950]: 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:27:13 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:13] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751279230 101 Jun 30 11:27:13 simonpi volumio[4950]: 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:27:13 simonpi volumio[4950]: 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:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:13 simonpi volumio[4950]: info: Discovery: Getting this device information Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:13 simonpi volumio[4950]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:13 simonpi volumio[4950]: info: CoreStateMachine::pushState Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:13 simonpi volumio[4950]: info: CoreStateMachine::updateTrackBlock Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrackBlock Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:13 simonpi volumio[4950]: info: Reloading queue from file Jun 30 11:27:13 simonpi volumio[4950]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:27:13 simonpi volumio[4950]: info: CoreStateMachine::pushState Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:13 simonpi volumio[4950]: info: CoreStateMachine::setRandom null Jun 30 11:27:13 simonpi volumio[4950]: info: CoreStateMachine::pushState Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:13 simonpi volumio[4950]: info: Setting Device type: Raspberry PI Jun 30 11:27:13 simonpi volumio[4950]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:27:13 simonpi volumio[4950]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:27:13 simonpi volumio[4950]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:27:13 simonpi volumio[4950]: 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:27:13 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:13 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 50. Jun 30 11:27:13 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:13 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:13 simonpi volumio[4950]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:13 simonpi volumio[4950]: info: CoreStateMachine::pushState Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:13 simonpi volumio[4950]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:27:13 simonpi volumio[4950]: info: Discovery: Found device SimonPi Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:13 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:27:13 simonpi volumio[4950]: info: Completed loading Core Plugins Jun 30 11:27:13 simonpi volumio[4950]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:13 simonpi volumio[4950]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:13 simonpi volumio[4950]: info: Reading ALSA contributions from plugins. Jun 30 11:27:13 simonpi volumio[4950]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:13 simonpi volumio[4950]: info: Output device has changed, restarting MPD Jun 30 11:27:13 simonpi sudo[5062]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:13 simonpi sudo[5062]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:13 simonpi sudo[5062]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:13 simonpi volumio[4950]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:13 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:13 simonpi sudo[5065]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:13 simonpi sudo[5065]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:13 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:27:14 simonpi volumio[4950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:14 simonpi volumio[4950]: info: ___________ START PLUGINS ___________ Jun 30 11:27:14 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:14 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:14 simonpi volumio[4950]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:27:14 simonpi volumio[4950]: info: Creating MPD Configuration file Jun 30 11:27:14 simonpi sudo[5088]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:14 simonpi sudo[5088]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:14 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:14 simonpi sudo[5088]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:14 simonpi sudo[5091]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:14 simonpi sudo[5091]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:14 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:27:14 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:14 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:14 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:14 simonpi volumio[4950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:14 simonpi volumio[4950]: info: [1751279234305] CoreMusicLibrary::Adding element Last_100 Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:14 simonpi volumio[4950]: info: [1751279234317] CoreMusicLibrary::Adding element Webradio Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:14 simonpi volumio[4950]: info: Initializing BBC Radios Jun 30 11:27:14 simonpi volumio[4950]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:14 simonpi sudo[5096]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:14 simonpi sudo[5096]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:14 simonpi sudo[5096]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: Loading i18n strings for locale en Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: FusionDsp - mixtype--------------------- Hardware Jun 30 11:27:14 simonpi volumio[4950]: info: Volumio Calling Home Jun 30 11:27:14 simonpi volumio[4950]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:14 simonpi volumio[4950]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:14 simonpi volumio[4950]: info: Reading ALSA contributions from plugins. Jun 30 11:27:14 simonpi volumio[4950]: info: MPD Permissions set Jun 30 11:27:14 simonpi volumio[4950]: info: MPD Permissions set Jun 30 11:27:14 simonpi volumio[4950]: 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:27:14 simonpi volumio[4950]: info: Volumio called home Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:14 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:15 simonpi volumio[4950]: info: Discovery: Getting this device information Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:15 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:15 simonpi volumio[4950]: info: Starting Shairport Sync Jun 30 11:27:15 simonpi volumio[4950]: info: Starting Shairport Sync Jun 30 11:27:15 simonpi volumio[4950]: info: Starting Shairport Sync Jun 30 11:27:15 simonpi sudo[5125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:15 simonpi sudo[5125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:15 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:15 simonpi sudo[5127]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:15 simonpi sudo[5127]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:15 simonpi volumio[4950]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:15 simonpi volumio[4950]: info: Output device has changed, restarting MPD Jun 30 11:27:15 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:15 simonpi volumio[4950]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:15 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:15 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:15 simonpi sudo[5135]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:15 simonpi sudo[5135]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:15 simonpi volumio[4950]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:15 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:15 simonpi sudo[5129]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:15 simonpi sudo[5129]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:15 simonpi sudo[5133]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:15 simonpi sudo[5133]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:15 simonpi sudo[5133]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:15 simonpi sudo[5127]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:15 simonpi sudo[5125]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:15 simonpi volumio[4950]: info: MPD Permissions set Jun 30 11:27:15 simonpi volumio[4950]: info: Shairport-Sync Started Jun 30 11:27:15 simonpi volumio[4950]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:27:15 simonpi volumio[5060]: Traceback (most recent call last): Jun 30 11:27:15 simonpi volumio[5060]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:15 simonpi volumio[5060]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:15 simonpi volumio[5060]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:15 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:15 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:27:15 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:15 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:15 simonpi volumio[4950]: 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:27:15 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:15 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:15 simonpi volumio[4950]: info: Shairport-Sync Started Jun 30 11:27:15 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:15 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:15 simonpi sudo[5129]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:15 simonpi volumio[4950]: info: Shairport-Sync Started Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:27:15 simonpi volumio[4950]: info: Starting Shairport Sync Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:15 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:15 simonpi sudo[5154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:15 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:15 simonpi sudo[5154]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:15 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:27:15 simonpi volumio[4950]: info: Received Get System Info Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:15 simonpi volumio[4950]: info: Discovery: Getting this device information Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:15 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:15 simonpi volumio[4950]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:15 simonpi volumio[4950]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:15 simonpi sudo[5146]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:15 simonpi sudo[5146]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:15 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:15 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:15 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:15 simonpi sudo[5146]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:15 simonpi volumio[4950]: info: Listing playlists Jun 30 11:27:15 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:15 simonpi sudo[5154]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:15 simonpi volumio[4950]: info: Shairport-Sync Started Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:16 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:16 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:16 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:17 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:17 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:17 simonpi mpd[5157]: Jun 30 11:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:27:17 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:27:17 simonpi sudo[5135]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:17 simonpi sudo[5091]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:17 simonpi sudo[5065]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:17 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:17 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:17 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 51. Jun 30 11:27:17 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:17 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:17 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:18 simonpi volumio[4950]: info: FusionDsp - Jun 30 11:27:18 simonpi volumio[4950]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:18 simonpi volumio[4950]: 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:27:18 simonpi volumio[4950]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:18 simonpi volumio[4950]: info: camilladsp service started and running in background, instance 1 Jun 30 11:27:18 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:18 simonpi volumio[4950]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:18 simonpi volumio[4950]: 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:27:18 simonpi volumio[4950]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:18 simonpi volumio[4950]: info: FusionDsp loaded Jun 30 11:27:18 simonpi volumio[4950]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:18 simonpi sudo[5174]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:27:18 simonpi sudo[5174]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:18 simonpi volumio[4950]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:27:18 simonpi volumio[4950]: info: Adding Signal Path Element [object Object] Jun 30 11:27:18 simonpi volumio[4950]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:27:18 simonpi volumio[4950]: info: FusionDsp - ---- installed callbackRead Jun 30 11:27:18 simonpi volumio[4950]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:18 simonpi sudo[5174]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:18 simonpi volumio[4950]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:27:18 simonpi volumio[4950]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:27:18 simonpi volumio[4950]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:27:18 simonpi volumio[4950]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 30 11:27:18 simonpi volumio[4950]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 30 11:27:18 simonpi volumio[4950]: at listOnTimeout (internal/timers.js:523:9) Jun 30 11:27:18 simonpi volumio[4950]: at processTimers (internal/timers.js:497:7) { Jun 30 11:27:18 simonpi volumio[4950]: errno: -2, Jun 30 11:27:18 simonpi volumio[4950]: code: 'ENOENT', Jun 30 11:27:18 simonpi volumio[4950]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:18 simonpi volumio[4950]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:18 simonpi volumio[4950]: spawnargs: [ Jun 30 11:27:18 simonpi volumio[4950]: '-p', Jun 30 11:27:18 simonpi volumio[4950]: 9876, Jun 30 11:27:18 simonpi volumio[4950]: '-o', Jun 30 11:27:18 simonpi volumio[4950]: '/tmp/camilladsp.log', Jun 30 11:27:18 simonpi volumio[4950]: '-l', Jun 30 11:27:18 simonpi volumio[4950]: 'warn', Jun 30 11:27:18 simonpi volumio[4950]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:27:18 simonpi volumio[4950]: ] Jun 30 11:27:18 simonpi volumio[4950]: } Jun 30 11:27:18 simonpi volumio[4950]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:19 simonpi sudo[5185]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:26 Jun 30 11:27:19 simonpi sudo[5185]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:19 simonpi volumio[5163]: Traceback (most recent call last): Jun 30 11:27:19 simonpi volumio[5163]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:19 simonpi volumio[5163]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:19 simonpi volumio[5163]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:19 simonpi sudo[5185]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:19 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:19] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:27:19 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:19] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:27:19 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:19 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:19 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:19 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:27:19 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:19 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:20 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:27:20 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 17. Jun 30 11:27:20 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:20 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:27:20 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:27:20 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:21 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:21 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 52. Jun 30 11:27:21 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:21 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:22 simonpi volumio[5196]: info: ------------------------------------------- Jun 30 11:27:22 simonpi volumio[5196]: info: ----- Volumio3 ---- Jun 30 11:27:22 simonpi volumio[5196]: info: ------------------------------------------- Jun 30 11:27:22 simonpi volumio[5196]: info: ----- System startup ---- Jun 30 11:27:22 simonpi volumio[5196]: info: ------------------------------------------- Jun 30 11:27:23 simonpi volumio[5196]: info: MYVOLUMIO Environment detected Jun 30 11:27:23 simonpi volumio[5196]: info: Plugin folders cleanup Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning category audio_interface Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning category miscellanea Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning category music_service Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning category plugins.json Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning category system_controller Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning category user_interface Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning into folder /data/plugins/ Jun 30 11:27:23 simonpi volumio[5196]: info: Scanning category audio_interface Jun 30 11:27:23 simonpi volumio[5196]: info: Plugin folders cleanup completed Jun 30 11:27:23 simonpi volumio[5196]: info: ------------------------------------------- Jun 30 11:27:23 simonpi volumio[5196]: info: ----- Core plugins startup ---- Jun 30 11:27:23 simonpi volumio[5196]: info: ------------------------------------------- Jun 30 11:27:23 simonpi volumio[5196]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:27:23 simonpi volumio[5196]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:27:23 simonpi volumio[5196]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:27:23 simonpi volumio[5196]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:27:23 simonpi volumio[5196]: info: Loading plugins from folder /data/plugins/ Jun 30 11:27:23 simonpi volumio[5196]: info: Loading plugin "system"... Jun 30 11:27:23 simonpi volumio[5196]: info: Loading plugin "appearance"... Jun 30 11:27:23 simonpi volumio[5246]: Traceback (most recent call last): Jun 30 11:27:23 simonpi volumio[5246]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:23 simonpi volumio[5246]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:23 simonpi volumio[5246]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:23 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:23 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "network"... Jun 30 11:27:24 simonpi volumio[5196]: info: Refreshing Cached IP Addresses Jun 30 11:27:24 simonpi sudo[5261]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:27:24 simonpi sudo[5261]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:24 simonpi sudo[5263]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:27:24 simonpi sudo[5263]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:24 simonpi sudo[5263]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "services"... Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "alsa_controller"... Jun 30 11:27:24 simonpi sudo[5261]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:24 simonpi sudo[5273]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:27:24 simonpi sudo[5273]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:24 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:24] [connect] Successful connection Jun 30 11:27:24 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "wizard"... Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "networkfs"... Jun 30 11:27:24 simonpi volumio[5196]: info: Starting Udev Watcher for removable devices Jun 30 11:27:24 simonpi volumio[5196]: info: Ignoring mount for partition: boot Jun 30 11:27:24 simonpi volumio[5196]: info: Ignoring mount for partition: volumio Jun 30 11:27:24 simonpi volumio[5196]: info: Ignoring mount for partition: volumio_data Jun 30 11:27:24 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "upnp"... Jun 30 11:27:24 simonpi volumio[5196]: info: [1751279244929] Starting Upmpd Daemon Jun 30 11:27:24 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "my_music"... Jun 30 11:27:24 simonpi volumio[5196]: info: Loading plugin "mpd"... Jun 30 11:27:25 simonpi volumio[5196]: info: Plugin upnp_browser is not enabled Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "alarm-clock"... Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "airplay_emulation"... Jun 30 11:27:25 simonpi volumio[5196]: info: Starting Shairport Sync Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "last_100"... Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "webradio"... Jun 30 11:27:25 simonpi sudo[5273]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "i2s_dacs"... Jun 30 11:27:25 simonpi volumio[5196]: info: I2S DAC not set, start Auto-detection Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "volumiodiscovery"... Jun 30 11:27:25 simonpi volumio[5196]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:25 simonpi volumio[5196]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:25 simonpi volumio[5196]: *** WARNING *** For more information see Jun 30 11:27:25 simonpi node[5196]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:25 simonpi volumio[5196]: *** 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:27:25 simonpi volumio[5196]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:25 simonpi volumio[5196]: *** WARNING *** For more information see Jun 30 11:27:25 simonpi node[5196]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:25 simonpi node[5196]: *** WARNING *** For more information see Jun 30 11:27:25 simonpi node[5196]: *** 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:27:25 simonpi node[5196]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:25 simonpi node[5196]: *** WARNING *** For more information see Jun 30 11:27:25 simonpi volumio[5196]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:27:25 simonpi volumio[5196]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:27:25 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:25 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 53. Jun 30 11:27:25 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:25 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "outputs"... Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "albumart"... Jun 30 11:27:25 simonpi volumio[5196]: info: Plugin example_plugin is not enabled Jun 30 11:27:25 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "inputs"... Jun 30 11:27:25 simonpi volumio[5196]: info: Loading plugin "updater_comm"... Jun 30 11:27:26 simonpi volumio[5196]: info: Plugin mpdemulation is not enabled Jun 30 11:27:26 simonpi volumio[5196]: info: Loading plugin "rest_api"... Jun 30 11:27:26 simonpi volumio[5196]: info: Loading plugin "websocket"... Jun 30 11:27:26 simonpi volumio[5196]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:27:26 simonpi volumio[5196]: info: Loading plugin "fusiondsp"... Jun 30 11:27:26 simonpi volumio[5196]: Forking 3 albumart workers Jun 30 11:27:26 simonpi volumio[5196]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:27:27 simonpi volumio[5196]: info: Loading i18n strings for locale en Jun 30 11:27:27 simonpi volumio[5196]: Updating browse sources language Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::initPlayerControls Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:27 simonpi volumio[5196]: Express server listening on port 3000 Jun 30 11:27:27 simonpi volumio[5196]: [Metrics] WebUI: 6s 246.36ms Jun 30 11:27:27 simonpi volumio[5291]: Traceback (most recent call last): Jun 30 11:27:27 simonpi volumio[5291]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:27 simonpi volumio[5291]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:27 simonpi volumio[5291]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:27 simonpi volumio[5196]: Starting albumart workers Jun 30 11:27:27 simonpi volumio[5196]: info: CoreStateMachine::resetVolumioState Jun 30 11:27:27 simonpi volumio[5196]: info: CoreStateMachine::getcurrentVolume Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:27 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:27 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:27 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:28 simonpi volumio[5196]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:27:28 simonpi volumio[5196]: Starting albumart workers Jun 30 11:27:28 simonpi volumio[5196]: 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:27:28 simonpi volumio[5196]: 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:27:28 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:28] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751279244 101 Jun 30 11:27:28 simonpi volumio[5196]: 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:27:28 simonpi volumio[5196]: 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:27:28 simonpi volumio[5196]: Starting albumart workers Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:28 simonpi volumio[5196]: info: Discovery: Getting this device information Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:28 simonpi volumio[5196]: info: Reloading queue from file Jun 30 11:27:28 simonpi volumio[5196]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:28 simonpi volumio[5196]: info: CoreStateMachine::pushState Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:28 simonpi volumio[5196]: info: CoreStateMachine::updateTrackBlock Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrackBlock Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:28 simonpi volumio[5196]: info: Setting Device type: Raspberry PI Jun 30 11:27:28 simonpi volumio[5196]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:27:28 simonpi volumio[5196]: info: CoreStateMachine::pushState Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:28 simonpi volumio[5196]: info: CoreStateMachine::setRandom null Jun 30 11:27:28 simonpi volumio[5196]: info: CoreStateMachine::pushState Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:28 simonpi volumio[5196]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:27:28 simonpi volumio[5196]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:27:28 simonpi volumio[5196]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:27:28 simonpi volumio[5196]: 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:27:28 simonpi volumio[5196]: info: Completed loading Core Plugins Jun 30 11:27:28 simonpi volumio[5196]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:28 simonpi volumio[5196]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:28 simonpi volumio[5196]: info: Reading ALSA contributions from plugins. Jun 30 11:27:28 simonpi volumio[5196]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:27:28 simonpi volumio[5196]: info: Discovery: Found device SimonPi Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:27:28 simonpi volumio[5196]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:28 simonpi volumio[5196]: info: CoreStateMachine::pushState Jun 30 11:27:28 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:28 simonpi volumio[5196]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:28 simonpi volumio[5196]: info: Output device has changed, restarting MPD Jun 30 11:27:28 simonpi sudo[5348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:28 simonpi sudo[5348]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:28 simonpi volumio[5196]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:28 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:28 simonpi sudo[5348]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:28 simonpi sudo[5352]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:28 simonpi sudo[5352]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:28 simonpi volumio[5196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:28 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:27:28 simonpi volumio[5196]: info: ___________ START PLUGINS ___________ Jun 30 11:27:28 simonpi volumio[5196]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:27:28 simonpi volumio[5196]: info: Creating MPD Configuration file Jun 30 11:27:28 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:28 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:29 simonpi sudo[5360]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:29 simonpi sudo[5360]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:29 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:29 simonpi sudo[5360]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:29 simonpi sudo[5362]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:29 simonpi sudo[5362]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:29 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:27:29 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:29 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:29 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:29 simonpi volumio[5196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:29 simonpi volumio[5196]: info: [1751279249186] CoreMusicLibrary::Adding element Last_100 Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:29 simonpi volumio[5196]: info: [1751279249196] CoreMusicLibrary::Adding element Webradio Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:29 simonpi volumio[5196]: info: Initializing BBC Radios Jun 30 11:27:29 simonpi volumio[5196]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:29 simonpi sudo[5372]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:29 simonpi sudo[5372]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:29 simonpi sudo[5372]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: Loading i18n strings for locale en Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: FusionDsp - mixtype--------------------- Hardware Jun 30 11:27:29 simonpi volumio[5196]: info: Volumio Calling Home Jun 30 11:27:29 simonpi volumio[5196]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:29 simonpi volumio[5196]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:29 simonpi volumio[5196]: info: Reading ALSA contributions from plugins. Jun 30 11:27:29 simonpi volumio[5196]: info: MPD Permissions set Jun 30 11:27:29 simonpi volumio[5196]: info: MPD Permissions set Jun 30 11:27:29 simonpi volumio[5196]: 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:27:29 simonpi volumio[5196]: info: Volumio called home Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:29 simonpi volumio[5196]: info: Starting Shairport Sync Jun 30 11:27:29 simonpi volumio[5196]: info: Starting Shairport Sync Jun 30 11:27:29 simonpi volumio[5196]: info: Starting Shairport Sync Jun 30 11:27:29 simonpi sudo[5404]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:29 simonpi sudo[5404]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:29 simonpi sudo[5406]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:29 simonpi sudo[5406]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:29 simonpi sudo[5409]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:29 simonpi volumio[5196]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:29 simonpi volumio[5196]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:29 simonpi sudo[5409]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:29 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:29 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:29 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:29 simonpi volumio[5196]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:29 simonpi volumio[5196]: info: Output device has changed, restarting MPD Jun 30 11:27:29 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:29 simonpi sudo[5406]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:29 simonpi sudo[5409]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:29 simonpi sudo[5404]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:30 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:30 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 54. Jun 30 11:27:30 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:30 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:30 simonpi volumio[5196]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:30 simonpi sudo[5417]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:30 simonpi sudo[5414]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:30 simonpi sudo[5417]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:30 simonpi sudo[5414]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:30 simonpi sudo[5414]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:30 simonpi volumio[5196]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:30 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:27:30 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:30 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:30 simonpi volumio[5196]: info: MPD Permissions set Jun 30 11:27:30 simonpi volumio[5196]: info: Shairport-Sync Started Jun 30 11:27:30 simonpi volumio[5196]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:27:30 simonpi volumio[5196]: info: Shairport-Sync Started Jun 30 11:27:30 simonpi volumio[5196]: info: Shairport-Sync Started Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:30 simonpi volumio[5196]: info: Starting Shairport Sync Jun 30 11:27:30 simonpi sudo[5432]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:30 simonpi sudo[5432]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:30 simonpi sudo[5425]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:30 simonpi sudo[5425]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:30 simonpi sudo[5425]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:30 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:30 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:30 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:30 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:30 simonpi sudo[5432]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:30 simonpi volumio[5196]: info: Shairport-Sync Started Jun 30 11:27:31 simonpi volumio[5196]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:31 simonpi volumio[5196]: 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:27:31 simonpi volumio[5196]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:31 simonpi volumio[5196]: info: camilladsp service started and running in background, instance 1 Jun 30 11:27:31 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:31 simonpi volumio[5196]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:31 simonpi volumio[5196]: 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:27:31 simonpi volumio[5196]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:31 simonpi volumio[5196]: info: FusionDsp loaded Jun 30 11:27:31 simonpi volumio[5196]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:31 simonpi sudo[5449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:27:31 simonpi sudo[5449]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:31 simonpi volumio[5196]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:27:31 simonpi volumio[5196]: info: Adding Signal Path Element [object Object] Jun 30 11:27:31 simonpi volumio[5196]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:27:31 simonpi volumio[5196]: info: FusionDsp - ---- installed callbackRead Jun 30 11:27:31 simonpi volumio[5196]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:31 simonpi sudo[5449]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:31 simonpi volumio[5196]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:27:31 simonpi volumio[5196]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:27:31 simonpi volumio[5196]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:27:31 simonpi volumio[5196]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jun 30 11:27:31 simonpi volumio[5196]: errno: -2, Jun 30 11:27:31 simonpi volumio[5196]: code: 'ENOENT', Jun 30 11:27:31 simonpi volumio[5196]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:31 simonpi volumio[5196]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:31 simonpi volumio[5196]: spawnargs: [ Jun 30 11:27:31 simonpi volumio[5196]: '-p', Jun 30 11:27:31 simonpi volumio[5196]: 9876, Jun 30 11:27:31 simonpi volumio[5196]: '-o', Jun 30 11:27:31 simonpi volumio[5196]: '/tmp/camilladsp.log', Jun 30 11:27:31 simonpi volumio[5196]: '-l', Jun 30 11:27:31 simonpi volumio[5196]: 'warn', Jun 30 11:27:31 simonpi volumio[5196]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:27:31 simonpi volumio[5196]: ] Jun 30 11:27:31 simonpi volumio[5196]: } Jun 30 11:27:31 simonpi volumio[5196]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:31 simonpi volumio[5416]: Traceback (most recent call last): Jun 30 11:27:31 simonpi volumio[5416]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:31 simonpi volumio[5416]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:31 simonpi volumio[5416]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:31 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:31 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:32 simonpi sudo[5462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:26 Jun 30 11:27:32 simonpi sudo[5462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:32 simonpi mpd[5435]: Jun 30 11:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:27:32 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:27:32 simonpi sudo[5362]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:32 simonpi sudo[5417]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:32 simonpi sudo[5352]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:32 simonpi sudo[5462]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:32 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:32] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:27:32 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:32] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:27:32 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:32 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:27:32 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:32 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:32 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:27:32 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 18. Jun 30 11:27:32 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:27:32 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:27:32 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:32 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:34 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:34 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 55. Jun 30 11:27:34 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:34 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:35 simonpi volumio[5475]: info: ------------------------------------------- Jun 30 11:27:35 simonpi volumio[5475]: info: ----- Volumio3 ---- Jun 30 11:27:35 simonpi volumio[5475]: info: ------------------------------------------- Jun 30 11:27:35 simonpi volumio[5475]: info: ----- System startup ---- Jun 30 11:27:35 simonpi volumio[5475]: info: ------------------------------------------- Jun 30 11:27:35 simonpi volumio[5488]: Traceback (most recent call last): Jun 30 11:27:35 simonpi volumio[5488]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:35 simonpi volumio[5488]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:35 simonpi volumio[5488]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:35 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:35 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:35 simonpi volumio[5475]: info: MYVOLUMIO Environment detected Jun 30 11:27:36 simonpi volumio[5475]: info: Plugin folders cleanup Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning category audio_interface Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning category miscellanea Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning category music_service Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning category plugins.json Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning category system_controller Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning category user_interface Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning into folder /data/plugins/ Jun 30 11:27:36 simonpi volumio[5475]: info: Scanning category audio_interface Jun 30 11:27:36 simonpi volumio[5475]: info: Plugin folders cleanup completed Jun 30 11:27:36 simonpi volumio[5475]: info: ------------------------------------------- Jun 30 11:27:36 simonpi volumio[5475]: info: ----- Core plugins startup ---- Jun 30 11:27:36 simonpi volumio[5475]: info: ------------------------------------------- Jun 30 11:27:36 simonpi volumio[5475]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:27:36 simonpi volumio[5475]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:27:36 simonpi volumio[5475]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:27:36 simonpi volumio[5475]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:27:36 simonpi volumio[5475]: info: Loading plugins from folder /data/plugins/ Jun 30 11:27:36 simonpi volumio[5475]: info: Loading plugin "system"... Jun 30 11:27:36 simonpi volumio[5475]: info: Loading plugin "appearance"... Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "network"... Jun 30 11:27:37 simonpi volumio[5475]: info: Refreshing Cached IP Addresses Jun 30 11:27:37 simonpi sudo[5504]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:27:37 simonpi sudo[5504]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:37 simonpi sudo[5506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:27:37 simonpi sudo[5506]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:37 simonpi sudo[5506]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:37 simonpi sudo[5504]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "services"... Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "alsa_controller"... Jun 30 11:27:37 simonpi sudo[5520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:27:37 simonpi sudo[5520]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:37 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "wizard"... Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "networkfs"... Jun 30 11:27:37 simonpi volumio[5475]: info: Starting Udev Watcher for removable devices Jun 30 11:27:37 simonpi volumio[5475]: info: Ignoring mount for partition: boot Jun 30 11:27:37 simonpi volumio[5475]: info: Ignoring mount for partition: volumio Jun 30 11:27:37 simonpi volumio[5475]: info: Ignoring mount for partition: volumio_data Jun 30 11:27:37 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "upnp"... Jun 30 11:27:37 simonpi volumio[5475]: info: [1751279257619] Starting Upmpd Daemon Jun 30 11:27:37 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "my_music"... Jun 30 11:27:37 simonpi volumio[5475]: info: Loading plugin "mpd"... Jun 30 11:27:37 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:37] [connect] Successful connection Jun 30 11:27:38 simonpi volumio[5475]: info: Plugin upnp_browser is not enabled Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "alarm-clock"... Jun 30 11:27:38 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:38 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 56. Jun 30 11:27:38 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:38 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "airplay_emulation"... Jun 30 11:27:38 simonpi volumio[5475]: info: Starting Shairport Sync Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "last_100"... Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "webradio"... Jun 30 11:27:38 simonpi sudo[5520]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "i2s_dacs"... Jun 30 11:27:38 simonpi volumio[5475]: info: I2S DAC not set, start Auto-detection Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "volumiodiscovery"... Jun 30 11:27:38 simonpi volumio[5475]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:38 simonpi volumio[5475]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:38 simonpi volumio[5475]: *** WARNING *** For more information see Jun 30 11:27:38 simonpi node[5475]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:38 simonpi volumio[5475]: *** 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:27:38 simonpi volumio[5475]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:38 simonpi volumio[5475]: *** WARNING *** For more information see Jun 30 11:27:38 simonpi node[5475]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:38 simonpi node[5475]: *** WARNING *** For more information see Jun 30 11:27:38 simonpi node[5475]: *** 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:27:38 simonpi node[5475]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:38 simonpi node[5475]: *** WARNING *** For more information see Jun 30 11:27:38 simonpi volumio[5475]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:27:38 simonpi volumio[5475]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:27:38 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "outputs"... Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "albumart"... Jun 30 11:27:38 simonpi volumio[5475]: info: Plugin example_plugin is not enabled Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "inputs"... Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "updater_comm"... Jun 30 11:27:38 simonpi volumio[5475]: info: Plugin mpdemulation is not enabled Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "rest_api"... Jun 30 11:27:38 simonpi volumio[5475]: info: Loading plugin "websocket"... Jun 30 11:27:39 simonpi volumio[5475]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:27:39 simonpi volumio[5475]: info: Loading plugin "fusiondsp"... Jun 30 11:27:39 simonpi volumio[5475]: Forking 3 albumart workers Jun 30 11:27:39 simonpi volumio[5475]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:27:39 simonpi volumio[5475]: info: Loading i18n strings for locale en Jun 30 11:27:39 simonpi volumio[5475]: Updating browse sources language Jun 30 11:27:39 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:39 simonpi volumio[5533]: Traceback (most recent call last): Jun 30 11:27:39 simonpi volumio[5533]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:39 simonpi volumio[5533]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:39 simonpi volumio[5533]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::initPlayerControls Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: Express server listening on port 3000 Jun 30 11:27:40 simonpi volumio[5475]: [Metrics] WebUI: 5s 821.73ms Jun 30 11:27:40 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:40 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::resetVolumioState Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::getcurrentVolume Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:40 simonpi volumio[5475]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:27:40 simonpi volumio[5475]: 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:27:40 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:40] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751279257 101 Jun 30 11:27:40 simonpi volumio[5475]: 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:27:40 simonpi volumio[5475]: 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:27:40 simonpi volumio[5475]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::pushState Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::updateTrackBlock Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrackBlock Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:40 simonpi volumio[5475]: info: Discovery: Getting this device information Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:40 simonpi volumio[5475]: Starting albumart workers Jun 30 11:27:40 simonpi volumio[5475]: info: Reloading queue from file Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::pushState Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:40 simonpi volumio[5475]: Starting albumart workers Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::setRandom null Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::pushState Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:40 simonpi volumio[5475]: info: Setting Device type: Raspberry PI Jun 30 11:27:40 simonpi volumio[5475]: Starting albumart workers Jun 30 11:27:40 simonpi volumio[5475]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:27:40 simonpi volumio[5475]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:27:40 simonpi volumio[5475]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:27:40 simonpi volumio[5475]: 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:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:27:40 simonpi volumio[5475]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:40 simonpi volumio[5475]: info: CoreStateMachine::pushState Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:40 simonpi volumio[5475]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:27:40 simonpi volumio[5475]: info: Discovery: Found device SimonPi Jun 30 11:27:40 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:40 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:40 simonpi volumio[5475]: info: Completed loading Core Plugins Jun 30 11:27:40 simonpi volumio[5475]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:41 simonpi volumio[5475]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:41 simonpi volumio[5475]: info: Reading ALSA contributions from plugins. Jun 30 11:27:41 simonpi volumio[5475]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:41 simonpi volumio[5475]: info: Output device has changed, restarting MPD Jun 30 11:27:41 simonpi volumio[5475]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:41 simonpi sudo[5577]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:41 simonpi sudo[5577]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:41 simonpi sudo[5577]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:41 simonpi sudo[5579]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:41 simonpi sudo[5579]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:41 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:27:41 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:41 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:41 simonpi volumio[5475]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:41 simonpi volumio[5475]: info: ___________ START PLUGINS ___________ Jun 30 11:27:41 simonpi volumio[5475]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:27:41 simonpi volumio[5475]: info: Creating MPD Configuration file Jun 30 11:27:41 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:41 simonpi sudo[5588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:41 simonpi sudo[5589]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:41 simonpi sudo[5589]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:41 simonpi sudo[5588]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:41 simonpi sudo[5588]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:41 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:27:41 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:41 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:41 simonpi volumio[5475]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:41 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:41 simonpi volumio[5475]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:41 simonpi volumio[5475]: info: [1751279261650] CoreMusicLibrary::Adding element Last_100 Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:41 simonpi volumio[5475]: info: [1751279261667] CoreMusicLibrary::Adding element Webradio Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:41 simonpi volumio[5475]: info: Initializing BBC Radios Jun 30 11:27:41 simonpi volumio[5475]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:41 simonpi sudo[5595]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:41 simonpi sudo[5595]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:41 simonpi sudo[5595]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:41 simonpi volumio[5475]: info: Loading i18n strings for locale en Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:27:41 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:41 simonpi volumio[5475]: info: FusionDsp - mixtype--------------------- Hardware Jun 30 11:27:41 simonpi volumio[5475]: info: Volumio Calling Home Jun 30 11:27:41 simonpi volumio[5475]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:42 simonpi volumio[5475]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:42 simonpi volumio[5475]: info: Reading ALSA contributions from plugins. Jun 30 11:27:42 simonpi volumio[5475]: info: MPD Permissions set Jun 30 11:27:42 simonpi volumio[5475]: info: MPD Permissions set Jun 30 11:27:42 simonpi volumio[5475]: 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:27:42 simonpi volumio[5475]: info: Volumio called home Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:42 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 57. Jun 30 11:27:42 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:42 simonpi volumio[5475]: info: Starting Shairport Sync Jun 30 11:27:42 simonpi volumio[5475]: info: Starting Shairport Sync Jun 30 11:27:42 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:42 simonpi volumio[5475]: info: Starting Shairport Sync Jun 30 11:27:42 simonpi sudo[5651]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:42 simonpi sudo[5651]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:42 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:42 simonpi sudo[5649]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:42 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:42 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:42 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:42 simonpi sudo[5653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:42 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:42 simonpi sudo[5651]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:42 simonpi sudo[5649]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:42 simonpi sudo[5653]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:42 simonpi volumio[5475]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:42 simonpi volumio[5475]: info: Output device has changed, restarting MPD Jun 30 11:27:42 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:42 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:42 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:42 simonpi volumio[5475]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:42 simonpi sudo[5663]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:42 simonpi sudo[5663]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:42 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:42 simonpi sudo[5660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:42 simonpi sudo[5660]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:42 simonpi sudo[5660]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:42 simonpi sudo[5653]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:42 simonpi sudo[5649]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:42 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:27:42 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:42 simonpi volumio[5475]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:42 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:42 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:42 simonpi volumio[5475]: info: Shairport-Sync Started Jun 30 11:27:42 simonpi volumio[5475]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:27:42 simonpi volumio[5475]: info: MPD Permissions set Jun 30 11:27:42 simonpi volumio[5475]: info: Shairport-Sync Started Jun 30 11:27:42 simonpi volumio[5475]: info: Shairport-Sync Started Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:42 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:42 simonpi sudo[5671]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:42 simonpi sudo[5671]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:42 simonpi volumio[5475]: info: Starting Shairport Sync Jun 30 11:27:42 simonpi sudo[5671]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:43 simonpi sudo[5681]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:43 simonpi sudo[5681]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:43 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:43 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:43 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:43 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:43 simonpi sudo[5681]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:43 simonpi volumio[5475]: 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:27:43 simonpi volumio[5475]: info: Shairport-Sync Started Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:43 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:27:43 simonpi volumio[5475]: info: Received Get System Info Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:43 simonpi volumio[5475]: info: Discovery: Getting this device information Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:43 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:43 simonpi volumio[5475]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:43 simonpi volumio[5475]: info: Listing playlists Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:43 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:43 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:44 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:44 simonpi volumio[5647]: Traceback (most recent call last): Jun 30 11:27:44 simonpi volumio[5647]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:44 simonpi volumio[5647]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:44 simonpi volumio[5647]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:44 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:44 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:44 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:44 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:44 simonpi mpd[5680]: Jun 30 11:27 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:27:44 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:27:44 simonpi sudo[5579]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:44 simonpi sudo[5589]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:44 simonpi sudo[5663]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:45 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:45 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:45 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:45 simonpi volumio[5475]: info: FusionDsp - Jun 30 11:27:46 simonpi volumio[5475]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:46 simonpi volumio[5475]: 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:27:46 simonpi volumio[5475]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:27:46 simonpi volumio[5475]: info: camilladsp service started and running in background, instance 1 Jun 30 11:27:46 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:46 simonpi volumio[5475]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:46 simonpi volumio[5475]: 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:27:46 simonpi volumio[5475]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:27:46 simonpi volumio[5475]: info: FusionDsp loaded Jun 30 11:27:46 simonpi volumio[5475]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:46 simonpi sudo[5698]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:27:46 simonpi sudo[5698]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:46 simonpi volumio[5475]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:27:46 simonpi volumio[5475]: info: Adding Signal Path Element [object Object] Jun 30 11:27:46 simonpi volumio[5475]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:27:46 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:46 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 58. Jun 30 11:27:46 simonpi volumio[5475]: info: FusionDsp - ---- installed callbackRead Jun 30 11:27:46 simonpi volumio[5475]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:46 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:46 simonpi volumio[5475]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:27:46 simonpi volumio[5475]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:27:46 simonpi volumio[5475]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:27:46 simonpi volumio[5475]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 30 11:27:46 simonpi volumio[5475]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 30 11:27:46 simonpi volumio[5475]: at listOnTimeout (internal/timers.js:523:9) Jun 30 11:27:46 simonpi volumio[5475]: at processTimers (internal/timers.js:497:7) { Jun 30 11:27:46 simonpi volumio[5475]: errno: -2, Jun 30 11:27:46 simonpi volumio[5475]: code: 'ENOENT', Jun 30 11:27:46 simonpi volumio[5475]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:46 simonpi volumio[5475]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:27:46 simonpi volumio[5475]: spawnargs: [ Jun 30 11:27:46 simonpi volumio[5475]: '-p', Jun 30 11:27:46 simonpi volumio[5475]: 9876, Jun 30 11:27:46 simonpi volumio[5475]: '-o', Jun 30 11:27:46 simonpi volumio[5475]: '/tmp/camilladsp.log', Jun 30 11:27:46 simonpi volumio[5475]: '-l', Jun 30 11:27:46 simonpi volumio[5475]: 'warn', Jun 30 11:27:46 simonpi volumio[5475]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:27:46 simonpi volumio[5475]: ] Jun 30 11:27:46 simonpi volumio[5475]: } Jun 30 11:27:46 simonpi volumio[5475]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:27:46 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:46 simonpi sudo[5698]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:47 simonpi sudo[5710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:26 Jun 30 11:27:47 simonpi sudo[5710]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:47 simonpi sudo[5710]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:47 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:47] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:27:47 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:47] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:27:47 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:47 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:27:47 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:47 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:47 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:27:47 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 19. Jun 30 11:27:47 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:27:47 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:27:47 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:27:47 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:27:48 simonpi volumio[5700]: Traceback (most recent call last): Jun 30 11:27:48 simonpi volumio[5700]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:48 simonpi volumio[5700]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:48 simonpi volumio[5700]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:48 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:48 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:49 simonpi volumio[5735]: info: ------------------------------------------- Jun 30 11:27:49 simonpi volumio[5735]: info: ----- Volumio3 ---- Jun 30 11:27:49 simonpi volumio[5735]: info: ------------------------------------------- Jun 30 11:27:49 simonpi volumio[5735]: info: ----- System startup ---- Jun 30 11:27:49 simonpi volumio[5735]: info: ------------------------------------------- Jun 30 11:27:50 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:50 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 59. Jun 30 11:27:50 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:50 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:50 simonpi volumio[5735]: info: MYVOLUMIO Environment detected Jun 30 11:27:50 simonpi volumio[5735]: info: Plugin folders cleanup Jun 30 11:27:50 simonpi volumio[5735]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:27:50 simonpi volumio[5735]: info: Scanning category audio_interface Jun 30 11:27:51 simonpi volumio[5735]: info: Scanning category miscellanea Jun 30 11:27:51 simonpi volumio[5735]: info: Scanning category music_service Jun 30 11:27:51 simonpi volumio[5735]: info: Scanning category plugins.json Jun 30 11:27:51 simonpi volumio[5735]: info: Scanning category system_controller Jun 30 11:27:51 simonpi volumio[5735]: info: Scanning category user_interface Jun 30 11:27:51 simonpi volumio[5735]: info: Scanning into folder /data/plugins/ Jun 30 11:27:51 simonpi volumio[5735]: info: Scanning category audio_interface Jun 30 11:27:51 simonpi volumio[5735]: info: Plugin folders cleanup completed Jun 30 11:27:51 simonpi volumio[5735]: info: ------------------------------------------- Jun 30 11:27:51 simonpi volumio[5735]: info: ----- Core plugins startup ---- Jun 30 11:27:51 simonpi volumio[5735]: info: ------------------------------------------- Jun 30 11:27:51 simonpi volumio[5735]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:27:51 simonpi volumio[5735]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:27:51 simonpi volumio[5735]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:27:51 simonpi volumio[5735]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:27:51 simonpi volumio[5735]: info: Loading plugins from folder /data/plugins/ Jun 30 11:27:51 simonpi volumio[5735]: info: Loading plugin "system"... Jun 30 11:27:51 simonpi volumio[5735]: info: Loading plugin "appearance"... Jun 30 11:27:51 simonpi volumio[5755]: Traceback (most recent call last): Jun 30 11:27:51 simonpi volumio[5755]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:51 simonpi volumio[5755]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:51 simonpi volumio[5755]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:52 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:52 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "network"... Jun 30 11:27:52 simonpi volumio[5735]: info: Refreshing Cached IP Addresses Jun 30 11:27:52 simonpi sudo[5765]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:27:52 simonpi sudo[5765]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:52 simonpi sudo[5767]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:27:52 simonpi sudo[5767]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:52 simonpi sudo[5767]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "services"... Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "alsa_controller"... Jun 30 11:27:52 simonpi sudo[5778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:27:52 simonpi sudo[5778]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:52 simonpi sudo[5765]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:52 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:52] [connect] Successful connection Jun 30 11:27:52 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "wizard"... Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "networkfs"... Jun 30 11:27:52 simonpi volumio[5735]: info: Starting Udev Watcher for removable devices Jun 30 11:27:52 simonpi volumio[5735]: info: Ignoring mount for partition: boot Jun 30 11:27:52 simonpi volumio[5735]: info: Ignoring mount for partition: volumio Jun 30 11:27:52 simonpi volumio[5735]: info: Ignoring mount for partition: volumio_data Jun 30 11:27:52 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "upnp"... Jun 30 11:27:52 simonpi volumio[5735]: info: [1751279272738] Starting Upmpd Daemon Jun 30 11:27:52 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "my_music"... Jun 30 11:27:52 simonpi volumio[5735]: info: Loading plugin "mpd"... Jun 30 11:27:53 simonpi volumio[5735]: info: Plugin upnp_browser is not enabled Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "alarm-clock"... Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "airplay_emulation"... Jun 30 11:27:53 simonpi volumio[5735]: info: Starting Shairport Sync Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "last_100"... Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "webradio"... Jun 30 11:27:53 simonpi sudo[5778]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "i2s_dacs"... Jun 30 11:27:53 simonpi volumio[5735]: info: I2S DAC not set, start Auto-detection Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "volumiodiscovery"... Jun 30 11:27:53 simonpi volumio[5735]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:53 simonpi volumio[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:53 simonpi volumio[5735]: *** WARNING *** For more information see Jun 30 11:27:53 simonpi node[5735]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:27:53 simonpi volumio[5735]: *** 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:27:53 simonpi volumio[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:53 simonpi volumio[5735]: *** WARNING *** For more information see Jun 30 11:27:53 simonpi node[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:53 simonpi node[5735]: *** WARNING *** For more information see Jun 30 11:27:53 simonpi node[5735]: *** 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:27:53 simonpi node[5735]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:27:53 simonpi node[5735]: *** WARNING *** For more information see Jun 30 11:27:53 simonpi volumio[5735]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:27:53 simonpi volumio[5735]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:27:53 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "outputs"... Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "albumart"... Jun 30 11:27:53 simonpi volumio[5735]: info: Plugin example_plugin is not enabled Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "inputs"... Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "updater_comm"... Jun 30 11:27:53 simonpi volumio[5735]: info: Plugin mpdemulation is not enabled Jun 30 11:27:53 simonpi volumio[5735]: info: Loading plugin "rest_api"... Jun 30 11:27:54 simonpi volumio[5735]: info: Loading plugin "websocket"... Jun 30 11:27:54 simonpi volumio[5735]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:27:54 simonpi volumio[5735]: info: Loading plugin "fusiondsp"... Jun 30 11:27:54 simonpi volumio[5735]: Forking 3 albumart workers Jun 30 11:27:54 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:54 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 60. Jun 30 11:27:54 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:54 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:54 simonpi volumio[5735]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:27:54 simonpi volumio[5735]: info: Loading i18n strings for locale en Jun 30 11:27:55 simonpi volumio[5735]: Updating browse sources language Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:55 simonpi volumio[5735]: Starting albumart workers Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::initPlayerControls Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: Express server listening on port 3000 Jun 30 11:27:55 simonpi volumio[5735]: [Metrics] WebUI: 6s 200.36ms Jun 30 11:27:55 simonpi volumio[5735]: info: CoreStateMachine::resetVolumioState Jun 30 11:27:55 simonpi volumio[5735]: info: CoreStateMachine::getcurrentVolume Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:55 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:55 simonpi volumio[5735]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:27:55 simonpi volumio[5735]: 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:27:55 simonpi volumio[5735]: Starting albumart workers Jun 30 11:27:55 simonpi volumio[5735]: 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:27:55 simonpi volumio-remote-updater[524]: [2025-06-30 11:27:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751279272 101 Jun 30 11:27:55 simonpi volumio[5735]: 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:27:55 simonpi volumio[5735]: Starting albumart workers Jun 30 11:27:56 simonpi volumio[5735]: info: Reloading queue from file Jun 30 11:27:56 simonpi volumio[5735]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:27:56 simonpi volumio[5735]: info: CoreStateMachine::pushState Jun 30 11:27:56 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:56 simonpi volumio[5735]: info: CoreStateMachine::setRandom null Jun 30 11:27:56 simonpi volumio[5735]: info: CoreStateMachine::pushState Jun 30 11:27:56 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:56 simonpi volumio[5735]: info: Setting Device type: Raspberry PI Jun 30 11:27:56 simonpi volumio[5735]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:27:56 simonpi volumio[5735]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:27:56 simonpi volumio[5735]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:27:56 simonpi volumio[5735]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:56 simonpi volumio[5735]: info: CoreStateMachine::pushState Jun 30 11:27:56 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:56 simonpi volumio[5735]: info: CoreStateMachine::updateTrackBlock Jun 30 11:27:56 simonpi volumio[5735]: info: CorePlayQueue::getTrackBlock Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:27:56 simonpi volumio[5735]: 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:27:56 simonpi volumio[5735]: info: Completed loading Core Plugins Jun 30 11:27:56 simonpi volumio[5735]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:56 simonpi volumio[5735]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:27:56 simonpi volumio[5735]: info: Discovery: Found device SimonPi Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:56 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:56 simonpi volumio[5824]: Traceback (most recent call last): Jun 30 11:27:56 simonpi volumio[5824]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:27:56 simonpi volumio[5824]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:27:56 simonpi volumio[5824]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:27:56 simonpi volumio[5735]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:56 simonpi volumio[5735]: info: Reading ALSA contributions from plugins. Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jun 30 11:27:56 simonpi volumio[5735]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:56 simonpi volumio[5735]: info: Output device has changed, restarting MPD Jun 30 11:27:56 simonpi volumio[5735]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:56 simonpi sudo[5847]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:56 simonpi sudo[5847]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:56 simonpi sudo[5847]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:56 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:27:56 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:27:56 simonpi sudo[5849]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:56 simonpi sudo[5849]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:56 simonpi volumio[5735]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:56 simonpi volumio[5735]: info: ___________ START PLUGINS ___________ Jun 30 11:27:56 simonpi volumio[5735]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:27:56 simonpi volumio[5735]: info: Creating MPD Configuration file Jun 30 11:27:56 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:27:56 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:56 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:56 simonpi sudo[5856]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:56 simonpi volumio[5735]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:56 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:56 simonpi sudo[5856]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:56 simonpi sudo[5856]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:56 simonpi sudo[5859]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:56 simonpi sudo[5859]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:56 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:27:56 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:56 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:56 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:56 simonpi volumio[5735]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:56 simonpi volumio[5735]: info: [1751279276935] CoreMusicLibrary::Adding element Last_100 Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:27:56 simonpi volumio[5735]: info: [1751279276945] CoreMusicLibrary::Adding element Webradio Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:56 simonpi volumio[5735]: info: Initializing BBC Radios Jun 30 11:27:56 simonpi volumio[5735]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:27:56 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:57 simonpi sudo[5872]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:57 simonpi sudo[5872]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:57 simonpi sudo[5872]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:57 simonpi volumio[5735]: info: Loading i18n strings for locale en Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: FusionDsp - mixtype--------------------- Hardware Jun 30 11:27:57 simonpi volumio[5735]: info: Volumio Calling Home Jun 30 11:27:57 simonpi volumio[5735]: info: Preparing to generate the ALSA configuration file Jun 30 11:27:57 simonpi volumio[5735]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:27:57 simonpi volumio[5735]: info: Reading ALSA contributions from plugins. Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::volumioGetVisibleSources Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:57 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jun 30 11:27:57 simonpi volumio[5735]: info: Received Get System Info Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:27:57 simonpi volumio[5735]: info: Discovery: Getting this device information Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:57 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:57 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:57 simonpi volumio[5735]: info: Listing playlists Jun 30 11:27:57 simonpi volumio[5735]: info: MPD Permissions set Jun 30 11:27:57 simonpi volumio[5735]: info: MPD Permissions set Jun 30 11:27:57 simonpi volumio[5735]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:27:57 simonpi volumio[5735]: info: CoreStateMachine::pushState Jun 30 11:27:57 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::volumioPushState Jun 30 11:27:57 simonpi volumio[5735]: info: Volumio called home Jun 30 11:27:57 simonpi volumio[5735]: 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:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::getUIConfigOnPlugin Jun 30 11:27:57 simonpi volumio[5735]: info: Starting Shairport Sync Jun 30 11:27:57 simonpi volumio[5735]: info: Starting Shairport Sync Jun 30 11:27:57 simonpi volumio[5735]: info: Starting Shairport Sync Jun 30 11:27:57 simonpi sudo[5909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:57 simonpi sudo[5909]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:57 simonpi sudo[5911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:57 simonpi sudo[5911]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:57 simonpi volumio[5735]: info: CoreCommandRouter::volumioGetState Jun 30 11:27:57 simonpi volumio[5735]: info: CorePlayQueue::getTrack 0 Jun 30 11:27:57 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:57 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:57 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:57 simonpi sudo[5914]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:27:57 simonpi sudo[5914]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:58 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:58 simonpi sudo[5909]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:58 simonpi volumio[5735]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:27:58 simonpi volumio[5735]: info: Output device has changed, restarting MPD Jun 30 11:27:58 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:27:58 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 30 11:27:58 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:27:58 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:58 simonpi volumio[5735]: info: Output device has changed, restarting Shairport Sync Jun 30 11:27:58 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:27:58 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:27:58 simonpi sudo[5919]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:27:58 simonpi sudo[5919]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:58 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:27:58 simonpi sudo[5911]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:58 simonpi sudo[5921]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:27:58 simonpi sudo[5921]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:58 simonpi sudo[5914]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:58 simonpi sudo[5919]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:58 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:27:58 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:27:58 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:27:58 simonpi volumio[5735]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:27:58 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:27:58 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:27:58 simonpi sudo[5930]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:27:58 simonpi sudo[5930]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:27:58 simonpi sudo[5930]: pam_unix(sudo:session): session closed for user root Jun 30 11:27:58 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:27:58 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:27:58 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 61. Jun 30 11:27:58 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:27:58 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:27:58 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:27:59 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:27:59 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:28:00 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:28:00 simonpi mpd[5932]: Jun 30 11:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:28:00 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:28:00 simonpi sudo[5859]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:00 simonpi sudo[5921]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:00 simonpi sudo[5849]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:00 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:28:00 simonpi volumio[5933]: Traceback (most recent call last): Jun 30 11:28:00 simonpi volumio[5933]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:28:00 simonpi volumio[5933]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:28:00 simonpi volumio[5933]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:28:00 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:28:00 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:00 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:28:00 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:28:01 simonpi volumio[5735]: info: FusionDsp - Jun 30 11:28:01 simonpi volumio[5735]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:28:01 simonpi volumio[5735]: 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:28:01 simonpi volumio[5735]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:28:01 simonpi volumio[5735]: info: camilladsp service started and running in background, instance 1 Jun 30 11:28:01 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:01 simonpi volumio[5735]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:28:01 simonpi volumio[5735]: 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:28:01 simonpi volumio[5735]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:28:01 simonpi volumio[5735]: info: FusionDsp loaded Jun 30 11:28:01 simonpi volumio[5735]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:28:01 simonpi sudo[5946]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:28:01 simonpi sudo[5946]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:01 simonpi volumio[5735]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:28:01 simonpi volumio[5735]: info: Adding Signal Path Element [object Object] Jun 30 11:28:01 simonpi volumio[5735]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:28:01 simonpi volumio[5735]: info: FusionDsp - ---- installed callbackRead Jun 30 11:28:01 simonpi volumio[5735]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:28:01 simonpi volumio[5735]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:28:01 simonpi volumio[5735]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:28:01 simonpi volumio[5735]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:28:01 simonpi volumio[5735]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jun 30 11:28:01 simonpi volumio[5735]: at runNextTicks (internal/process/task_queues.js:62:3) Jun 30 11:28:01 simonpi volumio[5735]: at listOnTimeout (internal/timers.js:523:9) Jun 30 11:28:01 simonpi volumio[5735]: at processTimers (internal/timers.js:497:7) { Jun 30 11:28:01 simonpi volumio[5735]: errno: -2, Jun 30 11:28:01 simonpi volumio[5735]: code: 'ENOENT', Jun 30 11:28:01 simonpi volumio[5735]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:28:01 simonpi volumio[5735]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:28:01 simonpi volumio[5735]: spawnargs: [ Jun 30 11:28:01 simonpi volumio[5735]: '-p', Jun 30 11:28:01 simonpi volumio[5735]: 9876, Jun 30 11:28:01 simonpi volumio[5735]: '-o', Jun 30 11:28:01 simonpi volumio[5735]: '/tmp/camilladsp.log', Jun 30 11:28:01 simonpi volumio[5735]: '-l', Jun 30 11:28:01 simonpi volumio[5735]: 'warn', Jun 30 11:28:01 simonpi volumio[5735]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:28:01 simonpi volumio[5735]: ] Jun 30 11:28:01 simonpi volumio[5735]: } Jun 30 11:28:01 simonpi volumio[5735]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:28:02 simonpi sudo[5957]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:27 Jun 30 11:28:02 simonpi sudo[5957]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:02 simonpi sudo[5957]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:02 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:02] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:28:02 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:02] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:28:02 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:02 simonpi sudo[5946]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:02 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:28:02 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:28:02 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:28:02 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 62. Jun 30 11:28:02 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:28:02 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:28:02 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:28:02 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:28:02 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 20. Jun 30 11:28:02 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:28:02 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:28:02 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:28:02 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:28:04 simonpi volumio[5976]: Traceback (most recent call last): Jun 30 11:28:04 simonpi volumio[5976]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:28:04 simonpi volumio[5976]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:28:04 simonpi volumio[5976]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:28:04 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:04 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:28:05 simonpi volumio[5982]: info: ------------------------------------------- Jun 30 11:28:05 simonpi volumio[5982]: info: ----- Volumio3 ---- Jun 30 11:28:05 simonpi volumio[5982]: info: ------------------------------------------- Jun 30 11:28:05 simonpi volumio[5982]: info: ----- System startup ---- Jun 30 11:28:05 simonpi volumio[5982]: info: ------------------------------------------- Jun 30 11:28:05 simonpi volumio[5982]: info: MYVOLUMIO Environment detected Jun 30 11:28:05 simonpi volumio[5982]: info: Plugin folders cleanup Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning category audio_interface Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning category miscellanea Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning category music_service Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning category plugins.json Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning category system_controller Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning category user_interface Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning into folder /data/plugins/ Jun 30 11:28:05 simonpi volumio[5982]: info: Scanning category audio_interface Jun 30 11:28:05 simonpi volumio[5982]: info: Plugin folders cleanup completed Jun 30 11:28:05 simonpi volumio[5982]: info: ------------------------------------------- Jun 30 11:28:05 simonpi volumio[5982]: info: ----- Core plugins startup ---- Jun 30 11:28:05 simonpi volumio[5982]: info: ------------------------------------------- Jun 30 11:28:05 simonpi volumio[5982]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:28:05 simonpi volumio[5982]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:28:05 simonpi volumio[5982]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:28:05 simonpi volumio[5982]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:28:05 simonpi volumio[5982]: info: Loading plugins from folder /data/plugins/ Jun 30 11:28:05 simonpi volumio[5982]: info: Loading plugin "system"... Jun 30 11:28:06 simonpi volumio[5982]: info: Loading plugin "appearance"... Jun 30 11:28:06 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:28:06 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 63. Jun 30 11:28:06 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:28:06 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "network"... Jun 30 11:28:07 simonpi volumio[5982]: info: Refreshing Cached IP Addresses Jun 30 11:28:07 simonpi sudo[6010]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:28:07 simonpi sudo[6010]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:07 simonpi sudo[6012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:28:07 simonpi sudo[6012]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:07 simonpi sudo[6012]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:07 simonpi sudo[6010]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "services"... Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "alsa_controller"... Jun 30 11:28:07 simonpi sudo[6023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:28:07 simonpi sudo[6023]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:07 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "wizard"... Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "networkfs"... Jun 30 11:28:07 simonpi volumio[5982]: info: Starting Udev Watcher for removable devices Jun 30 11:28:07 simonpi volumio[5982]: info: Ignoring mount for partition: boot Jun 30 11:28:07 simonpi volumio[5982]: info: Ignoring mount for partition: volumio Jun 30 11:28:07 simonpi volumio[5982]: info: Ignoring mount for partition: volumio_data Jun 30 11:28:07 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "upnp"... Jun 30 11:28:07 simonpi volumio[5982]: info: [1751279287597] Starting Upmpd Daemon Jun 30 11:28:07 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "my_music"... Jun 30 11:28:07 simonpi volumio[5982]: info: Loading plugin "mpd"... Jun 30 11:28:07 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:07] [connect] Successful connection Jun 30 11:28:08 simonpi volumio[5982]: info: Plugin upnp_browser is not enabled Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "alarm-clock"... Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "airplay_emulation"... Jun 30 11:28:08 simonpi volumio[5982]: info: Starting Shairport Sync Jun 30 11:28:08 simonpi volumio[6008]: Traceback (most recent call last): Jun 30 11:28:08 simonpi volumio[6008]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:28:08 simonpi volumio[6008]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:28:08 simonpi volumio[6008]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "last_100"... Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "webradio"... Jun 30 11:28:08 simonpi sudo[6023]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "i2s_dacs"... Jun 30 11:28:08 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:08 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:28:08 simonpi volumio[5982]: info: I2S DAC not set, start Auto-detection Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "volumiodiscovery"... Jun 30 11:28:08 simonpi volumio[5982]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:28:08 simonpi volumio[5982]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:08 simonpi volumio[5982]: *** WARNING *** For more information see Jun 30 11:28:08 simonpi node[5982]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:28:08 simonpi volumio[5982]: *** 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:28:08 simonpi volumio[5982]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:08 simonpi volumio[5982]: *** WARNING *** For more information see Jun 30 11:28:08 simonpi node[5982]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:08 simonpi node[5982]: *** WARNING *** For more information see Jun 30 11:28:08 simonpi node[5982]: *** 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:28:08 simonpi node[5982]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:08 simonpi node[5982]: *** WARNING *** For more information see Jun 30 11:28:08 simonpi volumio[5982]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:28:08 simonpi volumio[5982]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:28:08 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "outputs"... Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "albumart"... Jun 30 11:28:08 simonpi volumio[5982]: info: Plugin example_plugin is not enabled Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "inputs"... Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "updater_comm"... Jun 30 11:28:08 simonpi volumio[5982]: info: Plugin mpdemulation is not enabled Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "rest_api"... Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "websocket"... Jun 30 11:28:08 simonpi volumio[5982]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:28:08 simonpi volumio[5982]: info: Loading plugin "fusiondsp"... Jun 30 11:28:09 simonpi volumio[5982]: Forking 3 albumart workers Jun 30 11:28:09 simonpi volumio[5982]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:28:09 simonpi volumio[5982]: info: Loading i18n strings for locale en Jun 30 11:28:09 simonpi volumio[5982]: Updating browse sources language Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::initPlayerControls Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:28:09 simonpi volumio[5982]: Express server listening on port 3000 Jun 30 11:28:09 simonpi volumio[5982]: [Metrics] WebUI: 5s 569.68ms Jun 30 11:28:09 simonpi volumio[5982]: info: CoreStateMachine::resetVolumioState Jun 30 11:28:09 simonpi volumio[5982]: info: CoreStateMachine::getcurrentVolume Jun 30 11:28:09 simonpi volumio[5982]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:10 simonpi volumio[5982]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:28:10 simonpi volumio[5982]: 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:28:10 simonpi volumio[5982]: Starting albumart workers Jun 30 11:28:10 simonpi volumio[5982]: 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:28:10 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:10] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751279287 101 Jun 30 11:28:10 simonpi volumio[5982]: 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:28:10 simonpi volumio[5982]: 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:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:28:10 simonpi volumio[5982]: info: Discovery: Getting this device information Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:28:10 simonpi volumio[5982]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:28:10 simonpi volumio[5982]: info: CoreStateMachine::pushState Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:10 simonpi volumio[5982]: Starting albumart workers Jun 30 11:28:10 simonpi volumio[5982]: info: CoreStateMachine::updateTrackBlock Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrackBlock Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:28:10 simonpi volumio[5982]: Starting albumart workers Jun 30 11:28:10 simonpi volumio[5982]: info: Reloading queue from file Jun 30 11:28:10 simonpi volumio[5982]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:28:10 simonpi volumio[5982]: info: CoreStateMachine::pushState Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:10 simonpi volumio[5982]: info: CoreStateMachine::setRandom null Jun 30 11:28:10 simonpi volumio[5982]: info: CoreStateMachine::pushState Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:10 simonpi volumio[5982]: info: Setting Device type: Raspberry PI Jun 30 11:28:10 simonpi volumio[5982]: 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:28:10 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:28:10 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 64. Jun 30 11:28:10 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:28:10 simonpi volumio[5982]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:28:10 simonpi volumio[5982]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:28:10 simonpi volumio[5982]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:28:10 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:28:10 simonpi volumio[5982]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:28:10 simonpi volumio[5982]: info: CoreStateMachine::pushState Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:10 simonpi volumio[5982]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:28:10 simonpi volumio[5982]: info: Discovery: Found device SimonPi Jun 30 11:28:10 simonpi volumio[5982]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:10 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:10 simonpi volumio[5982]: info: Completed loading Core Plugins Jun 30 11:28:10 simonpi volumio[5982]: info: Preparing to generate the ALSA configuration file Jun 30 11:28:10 simonpi volumio[5982]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:28:10 simonpi volumio[5982]: info: Reading ALSA contributions from plugins. Jun 30 11:28:10 simonpi volumio[5982]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:28:10 simonpi volumio[5982]: info: Output device has changed, restarting MPD Jun 30 11:28:11 simonpi volumio[5982]: info: Output device has changed, restarting Shairport Sync Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:11 simonpi sudo[6083]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:28:11 simonpi sudo[6083]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:11 simonpi sudo[6085]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:28:11 simonpi sudo[6085]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:11 simonpi sudo[6083]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:11 simonpi volumio[5982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:11 simonpi volumio[5982]: info: ___________ START PLUGINS ___________ Jun 30 11:28:11 simonpi volumio[5982]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:28:11 simonpi volumio[5982]: info: Creating MPD Configuration file Jun 30 11:28:11 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:28:11 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:28:11 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:11 simonpi sudo[6092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:28:11 simonpi sudo[6092]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:11 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:28:11 simonpi sudo[6092]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:11 simonpi sudo[6095]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:28:11 simonpi sudo[6095]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:11 simonpi volumio[5982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:11 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:28:11 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:28:11 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:28:11 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:28:11 simonpi volumio[5982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:28:11 simonpi volumio[5982]: info: [1751279291549] CoreMusicLibrary::Adding element Last_100 Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:28:11 simonpi volumio[5982]: info: [1751279291596] CoreMusicLibrary::Adding element Webradio Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:28:11 simonpi sudo[6108]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:28:11 simonpi sudo[6108]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:11 simonpi volumio[5982]: info: Initializing BBC Radios Jun 30 11:28:11 simonpi sudo[6108]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:11 simonpi volumio[5982]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:11 simonpi volumio[5982]: info: Loading i18n strings for locale en Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:28:11 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:11 simonpi volumio[5982]: info: FusionDsp - mixtype--------------------- Hardware Jun 30 11:28:11 simonpi volumio[5982]: info: Volumio Calling Home Jun 30 11:28:11 simonpi volumio[5982]: info: Preparing to generate the ALSA configuration file Jun 30 11:28:12 simonpi volumio[5982]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:28:12 simonpi volumio[5982]: info: Reading ALSA contributions from plugins. Jun 30 11:28:12 simonpi volumio[5982]: info: MPD Permissions set Jun 30 11:28:12 simonpi volumio[5982]: info: MPD Permissions set Jun 30 11:28:12 simonpi volumio[5982]: 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:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: Volumio called home Jun 30 11:28:12 simonpi volumio[5982]: info: Starting Shairport Sync Jun 30 11:28:12 simonpi volumio[5982]: info: Starting Shairport Sync Jun 30 11:28:12 simonpi sudo[6153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:12 simonpi sudo[6153]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:12 simonpi volumio[5982]: info: Starting Shairport Sync Jun 30 11:28:12 simonpi sudo[6155]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:12 simonpi sudo[6155]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:12 simonpi sudo[6160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:12 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:28:12 simonpi sudo[6160]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:12 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:28:12 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:12 simonpi volumio[5982]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:12 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:12 simonpi sudo[6153]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:12 simonpi volumio[5982]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:28:12 simonpi volumio[5982]: info: Output device has changed, restarting MPD Jun 30 11:28:12 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:28:12 simonpi systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jun 30 11:28:12 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:28:12 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:12 simonpi volumio[5982]: info: Output device has changed, restarting Shairport Sync Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:12 simonpi sudo[6165]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:28:12 simonpi sudo[6165]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:12 simonpi sudo[6165]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:12 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:12 simonpi sudo[6155]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:12 simonpi volumio[6080]: Traceback (most recent call last): Jun 30 11:28:12 simonpi volumio[6080]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:28:12 simonpi volumio[6080]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:28:12 simonpi volumio[6080]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:28:12 simonpi sudo[6168]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:28:12 simonpi sudo[6160]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:12 simonpi sudo[6168]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:12 simonpi volumio[5982]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:12 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:28:12 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:28:12 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:28:12 simonpi volumio[5982]: info: MPD Permissions set Jun 30 11:28:12 simonpi volumio[5982]: info: Shairport-Sync Started Jun 30 11:28:12 simonpi volumio[5982]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:28:12 simonpi volumio[5982]: info: Shairport-Sync Started Jun 30 11:28:12 simonpi volumio[5982]: info: Shairport-Sync Started Jun 30 11:28:12 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:12 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:12 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:12 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:28:12 simonpi volumio[5982]: info: Starting Shairport Sync Jun 30 11:28:12 simonpi sudo[6183]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:12 simonpi sudo[6183]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:13 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:28:13 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:28:13 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:13 simonpi sudo[6176]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:28:13 simonpi sudo[6176]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:13 simonpi sudo[6176]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:13 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:13 simonpi sudo[6183]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:13 simonpi volumio[5982]: info: Shairport-Sync Started Jun 30 11:28:13 simonpi volumio[5982]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:28:13 simonpi volumio[5982]: 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:28:13 simonpi volumio[5982]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jun 30 11:28:13 simonpi volumio[5982]: info: camilladsp service started and running in background, instance 1 Jun 30 11:28:13 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:13 simonpi volumio[5982]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:28:13 simonpi volumio[5982]: 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:28:13 simonpi volumio[5982]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jun 30 11:28:13 simonpi volumio[5982]: info: FusionDsp loaded Jun 30 11:28:13 simonpi volumio[5982]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:28:13 simonpi sudo[6200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jun 30 11:28:13 simonpi sudo[6200]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:13 simonpi volumio[5982]: info: FusionDsp - Reporting Fusion DSP Enabled Jun 30 11:28:13 simonpi volumio[5982]: info: Adding Signal Path Element [object Object] Jun 30 11:28:13 simonpi volumio[5982]: info: Adding fusiondspeq DSP Signal Path Element Jun 30 11:28:13 simonpi volumio[5982]: info: FusionDsp - ---- installed callbackRead Jun 30 11:28:13 simonpi volumio[5982]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:28:13 simonpi volumio[5982]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jun 30 11:28:13 simonpi volumio[5982]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jun 30 11:28:13 simonpi volumio[5982]: at onErrorNT (internal/child_process.js:465:16) Jun 30 11:28:13 simonpi volumio[5982]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Jun 30 11:28:13 simonpi volumio[5982]: errno: -2, Jun 30 11:28:13 simonpi volumio[5982]: code: 'ENOENT', Jun 30 11:28:13 simonpi volumio[5982]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:28:13 simonpi volumio[5982]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jun 30 11:28:13 simonpi volumio[5982]: spawnargs: [ Jun 30 11:28:13 simonpi volumio[5982]: '-p', Jun 30 11:28:13 simonpi volumio[5982]: 9876, Jun 30 11:28:13 simonpi volumio[5982]: '-o', Jun 30 11:28:13 simonpi volumio[5982]: '/tmp/camilladsp.log', Jun 30 11:28:13 simonpi volumio[5982]: '-l', Jun 30 11:28:13 simonpi volumio[5982]: 'warn', Jun 30 11:28:13 simonpi volumio[5982]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jun 30 11:28:13 simonpi volumio[5982]: ] Jun 30 11:28:13 simonpi volumio[5982]: } Jun 30 11:28:13 simonpi volumio[5982]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:28:14 simonpi sudo[6212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:27 Jun 30 11:28:14 simonpi sudo[6212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:14 simonpi mpd[6187]: Jun 30 11:28 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jun 30 11:28:14 simonpi systemd[1]: Started Music Player Daemon. Jun 30 11:28:14 simonpi sudo[6095]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:14 simonpi sudo[6168]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:14 simonpi sudo[6085]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:14 simonpi sudo[6212]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:14 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:14] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jun 30 11:28:14 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:14] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jun 30 11:28:14 simonpi systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:14 simonpi sudo[6200]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:15 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:28:15 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 65. Jun 30 11:28:15 simonpi systemd[1]: volumio.service: Failed with result 'exit-code'. Jun 30 11:28:15 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:28:15 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:28:15 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:28:15 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:28:15 simonpi systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jun 30 11:28:15 simonpi systemd[1]: volumio.service: Scheduled restart job, restart counter is at 21. Jun 30 11:28:15 simonpi systemd[1]: Started dynamicswap service. Jun 30 11:28:15 simonpi systemd[1]: Stopped Volumio Backend Module. Jun 30 11:28:15 simonpi systemd[1]: Started Volumio Backend Module. Jun 30 11:28:15 simonpi systemd[1]: dynamicswap.service: Succeeded. Jun 30 11:28:16 simonpi volumio[6220]: Traceback (most recent call last): Jun 30 11:28:16 simonpi volumio[6220]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:28:16 simonpi volumio[6220]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:28:16 simonpi volumio[6220]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:28:16 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:16 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:28:17 simonpi volumio[6228]: info: ------------------------------------------- Jun 30 11:28:17 simonpi volumio[6228]: info: ----- Volumio3 ---- Jun 30 11:28:17 simonpi volumio[6228]: info: ------------------------------------------- Jun 30 11:28:17 simonpi volumio[6228]: info: ----- System startup ---- Jun 30 11:28:17 simonpi volumio[6228]: info: ------------------------------------------- Jun 30 11:28:18 simonpi volumio[6228]: info: MYVOLUMIO Environment detected Jun 30 11:28:18 simonpi volumio[6228]: info: Plugin folders cleanup Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning into folder /volumio/app/plugins/ Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning category audio_interface Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning category miscellanea Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning category music_service Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning category plugins.json Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning category system_controller Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning category user_interface Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning into folder /data/plugins/ Jun 30 11:28:18 simonpi volumio[6228]: info: Scanning category audio_interface Jun 30 11:28:18 simonpi volumio[6228]: info: Plugin folders cleanup completed Jun 30 11:28:18 simonpi volumio[6228]: info: ------------------------------------------- Jun 30 11:28:18 simonpi volumio[6228]: info: ----- Core plugins startup ---- Jun 30 11:28:18 simonpi volumio[6228]: info: ------------------------------------------- Jun 30 11:28:18 simonpi volumio[6228]: info: Loading plugins from folder /volumio/app/plugins/ Jun 30 11:28:18 simonpi volumio[6228]: info: Adding plugin upnp to MyMusic Plugins Jun 30 11:28:18 simonpi volumio[6228]: info: Adding plugin airplay_emulation to MyMusic Plugins Jun 30 11:28:18 simonpi volumio[6228]: info: Adding plugin upnp_browser to MyMusic Plugins Jun 30 11:28:18 simonpi volumio[6228]: info: Loading plugins from folder /data/plugins/ Jun 30 11:28:18 simonpi volumio[6228]: info: Loading plugin "system"... Jun 30 11:28:18 simonpi volumio[6228]: info: Loading plugin "appearance"... Jun 30 11:28:19 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:28:19 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 66. Jun 30 11:28:19 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:28:19 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:28:19 simonpi volumio[6228]: info: Loading plugin "network"... Jun 30 11:28:19 simonpi volumio[6228]: info: Refreshing Cached IP Addresses Jun 30 11:28:19 simonpi sudo[6255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jun 30 11:28:19 simonpi sudo[6255]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:19 simonpi sudo[6257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jun 30 11:28:19 simonpi sudo[6257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:19 simonpi sudo[6257]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:19 simonpi volumio[6228]: info: Loading plugin "services"... Jun 30 11:28:19 simonpi volumio[6228]: info: Loading plugin "alsa_controller"... Jun 30 11:28:19 simonpi sudo[6255]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:19 simonpi sudo[6267]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jun 30 11:28:19 simonpi sudo[6267]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:19 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:19] [connect] Successful connection Jun 30 11:28:20 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "wizard"... Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "networkfs"... Jun 30 11:28:20 simonpi volumio[6228]: info: Starting Udev Watcher for removable devices Jun 30 11:28:20 simonpi volumio[6228]: info: Ignoring mount for partition: boot Jun 30 11:28:20 simonpi volumio[6228]: info: Ignoring mount for partition: volumio Jun 30 11:28:20 simonpi volumio[6228]: info: Ignoring mount for partition: volumio_data Jun 30 11:28:20 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "volumio_command_line_client"... Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "upnp"... Jun 30 11:28:20 simonpi volumio[6228]: info: [1751279300182] Starting Upmpd Daemon Jun 30 11:28:20 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "my_music"... Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "mpd"... Jun 30 11:28:20 simonpi volumio[6228]: info: Plugin upnp_browser is not enabled Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "alarm-clock"... Jun 30 11:28:20 simonpi volumio[6253]: Traceback (most recent call last): Jun 30 11:28:20 simonpi volumio[6253]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:28:20 simonpi volumio[6253]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:28:20 simonpi volumio[6253]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "airplay_emulation"... Jun 30 11:28:20 simonpi volumio[6228]: info: Starting Shairport Sync Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "last_100"... Jun 30 11:28:20 simonpi sudo[6267]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:20 simonpi volumio[6228]: info: Loading plugin "webradio"... Jun 30 11:28:20 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:20 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "i2s_dacs"... Jun 30 11:28:21 simonpi volumio[6228]: info: I2S DAC not set, start Auto-detection Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "volumiodiscovery"... Jun 30 11:28:21 simonpi volumio[6228]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:28:21 simonpi volumio[6228]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:21 simonpi node[6228]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jun 30 11:28:21 simonpi volumio[6228]: *** WARNING *** For more information see Jun 30 11:28:21 simonpi volumio[6228]: *** 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:28:21 simonpi volumio[6228]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:21 simonpi volumio[6228]: *** WARNING *** For more information see Jun 30 11:28:21 simonpi node[6228]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:21 simonpi node[6228]: *** WARNING *** For more information see Jun 30 11:28:21 simonpi node[6228]: *** 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:28:21 simonpi node[6228]: *** WARNING *** Please fix your application to use the native API of Avahi! Jun 30 11:28:21 simonpi node[6228]: *** WARNING *** For more information see Jun 30 11:28:21 simonpi volumio[6228]: info: Applying required configuration parameters for plugin volumiodiscovery Jun 30 11:28:21 simonpi volumio[6228]: info: Discovery: Started advertising with name: SimonPi Jun 30 11:28:21 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "outputs"... Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "albumart"... Jun 30 11:28:21 simonpi volumio[6228]: info: Plugin example_plugin is not enabled Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "inputs"... Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "updater_comm"... Jun 30 11:28:21 simonpi volumio[6228]: info: Plugin mpdemulation is not enabled Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "rest_api"... Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "websocket"... Jun 30 11:28:21 simonpi volumio[6228]: info: Starting Socket.io Server version 2.3.0 Jun 30 11:28:21 simonpi volumio[6228]: info: Loading plugin "fusiondsp"... Jun 30 11:28:21 simonpi volumio[6228]: Forking 3 albumart workers Jun 30 11:28:21 simonpi volumio[6228]: info: Applying required configuration parameters for plugin fusiondsp Jun 30 11:28:22 simonpi volumio[6228]: info: Loading i18n strings for locale en Jun 30 11:28:22 simonpi volumio[6228]: Updating browse sources language Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::initPlayerControls Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: Express server listening on port 3000 Jun 30 11:28:22 simonpi volumio[6228]: [Metrics] WebUI: 5s 621.01ms Jun 30 11:28:22 simonpi volumio[6228]: info: CoreStateMachine::resetVolumioState Jun 30 11:28:22 simonpi volumio[6228]: info: CoreStateMachine::getcurrentVolume Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:22 simonpi volumio[6228]: info: Volumio Network Manager: Network status updated: 2 Jun 30 11:28:22 simonpi volumio[6228]: 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:28:22 simonpi volumio-remote-updater[524]: [2025-06-30 11:28:22] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1751279299 101 Jun 30 11:28:22 simonpi volumio[6228]: 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:28:22 simonpi volumio[6228]: 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:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jun 30 11:28:22 simonpi volumio[6228]: info: Discovery: Getting this device information Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:22 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jun 30 11:28:22 simonpi volumio[6228]: Starting albumart workers Jun 30 11:28:22 simonpi volumio[6228]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:28:22 simonpi volumio[6228]: info: CoreStateMachine::pushState Jun 30 11:28:22 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:28:22 simonpi volumio[6228]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:23 simonpi volumio[6228]: info: CoreStateMachine::updateTrackBlock Jun 30 11:28:23 simonpi volumio[6228]: info: CorePlayQueue::getTrackBlock Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::volumioRetrievevolume Jun 30 11:28:23 simonpi volumio[6228]: Starting albumart workers Jun 30 11:28:23 simonpi systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Jun 30 11:28:23 simonpi systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 67. Jun 30 11:28:23 simonpi volumio[6228]: info: Reloading queue from file Jun 30 11:28:23 simonpi volumio[6228]: info: CoreStateMachine::setRepeat null single undefined Jun 30 11:28:23 simonpi volumio[6228]: info: CoreStateMachine::pushState Jun 30 11:28:23 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:23 simonpi volumio[6228]: info: CoreStateMachine::setRandom null Jun 30 11:28:23 simonpi volumio[6228]: info: CoreStateMachine::pushState Jun 30 11:28:23 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:23 simonpi volumio[6228]: info: Setting Device type: Raspberry PI Jun 30 11:28:23 simonpi systemd[1]: Stopped FusionDsp Daemon. Jun 30 11:28:23 simonpi volumio[6228]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Jun 30 11:28:23 simonpi systemd[1]: Started FusionDsp Daemon. Jun 30 11:28:23 simonpi volumio[6228]: info: USB Boot Capable - System SBC Revision found in cpuinfo: 902120 Jun 30 11:28:23 simonpi volumio[6228]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Jun 30 11:28:23 simonpi volumio[6228]: Starting albumart workers Jun 30 11:28:23 simonpi volumio[6228]: 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:28:23 simonpi volumio[6228]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:23 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Jun 30 11:28:23 simonpi volumio[6228]: info: Discovery: adding a8b3bd95-28a2-4efb-b298-5a83aebe5187 Jun 30 11:28:23 simonpi volumio[6228]: info: Discovery: Found device SimonPi Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:23 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:23 simonpi volumio[6228]: info: VolumeController:: Volume=86 Mute =false Jun 30 11:28:23 simonpi volumio[6228]: info: CoreStateMachine::pushState Jun 30 11:28:23 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::volumioPushState Jun 30 11:28:23 simonpi volumio[6228]: info: Completed loading Core Plugins Jun 30 11:28:23 simonpi volumio[6228]: info: Preparing to generate the ALSA configuration file Jun 30 11:28:23 simonpi volumio[6228]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:28:23 simonpi volumio[6228]: info: Reading ALSA contributions from plugins. Jun 30 11:28:23 simonpi volumio[6228]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:28:23 simonpi volumio[6228]: info: Output device has changed, restarting MPD Jun 30 11:28:23 simonpi volumio[6228]: info: Output device has changed, restarting Shairport Sync Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:23 simonpi sudo[6368]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:28:23 simonpi sudo[6368]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:23 simonpi sudo[6366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:28:23 simonpi systemd[1]: Stopping Music Player Daemon... Jun 30 11:28:23 simonpi volumio[6228]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:23 simonpi volumio[6228]: info: ___________ START PLUGINS ___________ Jun 30 11:28:23 simonpi volumio[6228]: info: ControllerMpd::onStart: Initializing MPD Jun 30 11:28:23 simonpi sudo[6366]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:23 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:28:23 simonpi volumio[6228]: info: Creating MPD Configuration file Jun 30 11:28:23 simonpi sudo[6366]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:23 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:28:23 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:28:23 simonpi sudo[6376]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:28:23 simonpi sudo[6376]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:23 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:23 simonpi sudo[6376]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:24 simonpi sudo[6378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:28:24 simonpi sudo[6378]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:24 simonpi systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jun 30 11:28:24 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:28:24 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:28:24 simonpi volumio[6228]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:24 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:28:24 simonpi volumio[6228]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:28:24 simonpi volumio[6228]: info: [1751279304203] CoreMusicLibrary::Adding element Last_100 Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jun 30 11:28:24 simonpi volumio[6228]: info: [1751279304233] CoreMusicLibrary::Adding element Webradio Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:28:24 simonpi volumio[6228]: info: Initializing BBC Radios Jun 30 11:28:24 simonpi volumio[6228]: /usr/bin/md5sum: /sys/class/net/eth0/address: No such file or directory Jun 30 11:28:24 simonpi sudo[6384]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:28:24 simonpi sudo[6384]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:24 simonpi sudo[6384]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: Loading i18n strings for locale en Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: FusionDsp - mixtype--------------------- Hardware Jun 30 11:28:24 simonpi volumio[6228]: info: Volumio Calling Home Jun 30 11:28:24 simonpi volumio[6228]: info: Preparing to generate the ALSA configuration file Jun 30 11:28:24 simonpi volumio[6228]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jun 30 11:28:24 simonpi volumio[6228]: info: Reading ALSA contributions from plugins. Jun 30 11:28:24 simonpi volumio[6228]: info: MPD Permissions set Jun 30 11:28:24 simonpi volumio[6228]: info: MPD Permissions set Jun 30 11:28:24 simonpi volumio[6228]: info: Volumio called home Jun 30 11:28:24 simonpi volumio[6228]: 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:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:24 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6360]: Traceback (most recent call last): Jun 30 11:28:25 simonpi volumio[6360]: File "/data/plugins/audio_interface/fusiondsp/cgui/main.py", line 5, in Jun 30 11:28:25 simonpi volumio[6360]: from camilladsp_plot.validate_config import CamillaValidator Jun 30 11:28:25 simonpi volumio[6360]: ModuleNotFoundError: No module named 'camilladsp_plot' Jun 30 11:28:25 simonpi volumio[6228]: info: Starting Shairport Sync Jun 30 11:28:25 simonpi volumio[6228]: info: Starting Shairport Sync Jun 30 11:28:25 simonpi volumio[6228]: info: Starting Shairport Sync Jun 30 11:28:25 simonpi sudo[6436]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:25 simonpi sudo[6436]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:25 simonpi sudo[6441]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:25 simonpi sudo[6441]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:25 simonpi sudo[6438]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:25 simonpi sudo[6438]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:25 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:28:25 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:28:25 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::volumioGetState Jun 30 11:28:25 simonpi volumio[6228]: info: CorePlayQueue::getTrack 0 Jun 30 11:28:25 simonpi volumio[6228]: info: Asound.conf file unchanged, so no further update is needed Jun 30 11:28:25 simonpi volumio[6228]: info: Output device has changed, restarting MPD Jun 30 11:28:25 simonpi volumio[6228]: info: Output device has changed, restarting Shairport Sync Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:25 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:25 simonpi sudo[6441]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:25 simonpi sudo[6438]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:25 simonpi sudo[6436]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:25 simonpi systemd[1]: fusiondsp.service: Main process exited, code=exited, status=1/FAILURE Jun 30 11:28:25 simonpi sudo[6446]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jun 30 11:28:25 simonpi systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Jun 30 11:28:25 simonpi sudo[6446]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:25 simonpi sudo[6446]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:25 simonpi sudo[6448]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jun 30 11:28:25 simonpi sudo[6448]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:25 simonpi volumio[6228]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jun 30 11:28:25 simonpi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jun 30 11:28:25 simonpi systemd[1]: mpd.service: Succeeded. Jun 30 11:28:25 simonpi systemd[1]: Stopped Music Player Daemon. Jun 30 11:28:25 simonpi volumio[6228]: info: MPD Permissions set Jun 30 11:28:25 simonpi volumio[6228]: info: Shairport-Sync Started Jun 30 11:28:25 simonpi volumio[6228]: Error adding Membership: Error: addMembership EINVAL Jun 30 11:28:25 simonpi volumio[6228]: info: Shairport-Sync Started Jun 30 11:28:25 simonpi volumio[6228]: info: Shairport-Sync Started Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jun 30 11:28:25 simonpi volumio[6228]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jun 30 11:28:25 simonpi systemd[1]: Starting Music Player Daemon... Jun 30 11:28:25 simonpi volumio[6228]: info: Starting Shairport Sync Jun 30 11:28:25 simonpi volumio[6228]: 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:28:25 simonpi sudo[6462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jun 30 11:28:25 simonpi sudo[6462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:25 simonpi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jun 30 11:28:25 simonpi systemd[1]: shairport-sync.service: Succeeded. Jun 30 11:28:25 simonpi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:25 simonpi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jun 30 11:28:25 simonpi volumio[6228]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:28:25 simonpi sudo[6462]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:25 simonpi volumio[6228]: TypeError: Cannot read property 'off' of undefined Jun 30 11:28:25 simonpi volumio[6228]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Jun 30 11:28:25 simonpi volumio[6228]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jun 30 11:28:25 simonpi volumio[6228]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Jun 30 11:28:25 simonpi volumio[6228]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Jun 30 11:28:25 simonpi volumio[6228]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Jun 30 11:28:25 simonpi volumio[6228]: at Socket.emit (events.js:315:20) Jun 30 11:28:25 simonpi volumio[6228]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jun 30 11:28:25 simonpi volumio[6228]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Jun 30 11:28:25 simonpi volumio[6228]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jun 30 11:28:25 simonpi sudo[6456]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jun 30 11:28:25 simonpi sudo[6456]: pam_unix(sudo:session): session opened for user root by (uid=0) Jun 30 11:28:25 simonpi sudo[6456]: pam_unix(sudo:session): session closed for user root Jun 30 11:28:26 simonpi sudo[6479]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-06-30 11:27 Jun 30 11:28:26 simonpi sudo[6479]: 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"