-- Logs begin at Thu 2019-02-14 15:41:59 IST, end at Sat 2025-08-30 23:22:02 IST. -- Aug 30 23:21:00 volumio volumio[3221]: info: FusionDsp - undefined Aug 30 23:21:00 volumio volumio[3221]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:00 volumio volumio[3221]: 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 Aug 30 23:21:00 volumio volumio[3221]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:00 volumio volumio[3221]: info: camilladsp service started and running in background, instance 1 Aug 30 23:21:00 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:00 volumio volumio[3221]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:00 volumio volumio[3221]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 23:21:00 volumio volumio[3221]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:00 volumio volumio[3221]: info: FusionDsp loaded Aug 30 23:21:00 volumio volumio[3221]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:00 volumio sudo[3494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 23:21:00 volumio sudo[3494]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:00 volumio volumio[3221]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 23:21:00 volumio volumio[3221]: info: Adding Signal Path Element [object Object] Aug 30 23:21:00 volumio volumio[3221]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 23:21:00 volumio volumio[3221]: info: FusionDsp - ---- installed callbackRead Aug 30 23:21:00 volumio volumio[3221]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:00 volumio sudo[3494]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:00 volumio volumio[3221]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 23:21:00 volumio volumio[3221]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 23:21:00 volumio volumio[3221]: at onErrorNT (internal/child_process.js:465:16) Aug 30 23:21:00 volumio volumio[3221]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 23:21:00 volumio volumio[3221]: errno: -2, Aug 30 23:21:00 volumio volumio[3221]: code: 'ENOENT', Aug 30 23:21:00 volumio volumio[3221]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:00 volumio volumio[3221]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:00 volumio volumio[3221]: spawnargs: [ Aug 30 23:21:00 volumio volumio[3221]: '-p', Aug 30 23:21:00 volumio volumio[3221]: 9876, Aug 30 23:21:00 volumio volumio[3221]: '-o', Aug 30 23:21:00 volumio volumio[3221]: '/tmp/camilladsp.log', Aug 30 23:21:00 volumio volumio[3221]: '-l', Aug 30 23:21:00 volumio volumio[3221]: 'warn', Aug 30 23:21:00 volumio volumio[3221]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 23:21:00 volumio volumio[3221]: ] Aug 30 23:21:00 volumio volumio[3221]: } Aug 30 23:21:00 volumio volumio[3221]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:00 volumio mpd[3464]: Aug 30 23:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 23:21:00 volumio systemd[1]: Started Music Player Daemon. Aug 30 23:21:00 volumio sudo[3378]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:00 volumio sudo[3449]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:00 volumio sudo[3368]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:00 volumio sudo[3507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 23:20 Aug 30 23:21:00 volumio sudo[3507]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:00 volumio sudo[3507]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:01 volumio volumio-remote-updater[581]: [2025-08-30 23:21:01] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 30 23:21:01 volumio volumio-remote-updater[581]: [2025-08-30 23:21:01] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 30 23:21:01 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 30 23:21:01 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 30 23:21:01 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:01 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:01 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 30 23:21:01 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 10. Aug 30 23:21:01 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:01 volumio systemd[1]: Stopped Volumio Backend Module. Aug 30 23:21:01 volumio systemd[1]: Started Volumio Backend Module. Aug 30 23:21:01 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:02 volumio volumio[3518]: info: ------------------------------------------- Aug 30 23:21:02 volumio volumio[3518]: info: ----- Volumio3 ---- Aug 30 23:21:02 volumio volumio[3518]: info: ------------------------------------------- Aug 30 23:21:02 volumio volumio[3518]: info: ----- System startup ---- Aug 30 23:21:02 volumio volumio[3518]: info: ------------------------------------------- Aug 30 23:21:03 volumio volumio[3518]: info: MYVOLUMIO Environment detected Aug 30 23:21:03 volumio volumio[3518]: info: Plugin folders cleanup Aug 30 23:21:03 volumio volumio[3518]: info: Scanning into folder /volumio/app/plugins/ Aug 30 23:21:03 volumio volumio[3518]: info: Scanning category audio_interface Aug 30 23:21:03 volumio volumio[3518]: info: Scanning category miscellanea Aug 30 23:21:03 volumio volumio[3518]: info: Scanning category music_service Aug 30 23:21:03 volumio volumio[3518]: info: Scanning category plugins.json Aug 30 23:21:03 volumio volumio[3518]: info: Scanning category system_controller Aug 30 23:21:03 volumio volumio[3518]: info: Scanning category user_interface Aug 30 23:21:03 volumio volumio[3518]: info: Scanning into folder /data/plugins/ Aug 30 23:21:03 volumio volumio[3518]: info: Scanning category audio_interface Aug 30 23:21:03 volumio volumio[3518]: info: Plugin folders cleanup completed Aug 30 23:21:03 volumio volumio[3518]: info: ------------------------------------------- Aug 30 23:21:03 volumio volumio[3518]: info: ----- Core plugins startup ---- Aug 30 23:21:03 volumio volumio[3518]: info: ------------------------------------------- Aug 30 23:21:03 volumio volumio[3518]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 23:21:03 volumio volumio[3518]: info: Adding plugin upnp to MyMusic Plugins Aug 30 23:21:03 volumio volumio[3518]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 23:21:03 volumio volumio[3518]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 23:21:03 volumio volumio[3518]: info: Loading plugins from folder /data/plugins/ Aug 30 23:21:03 volumio volumio[3518]: info: Loading plugin "system"... Aug 30 23:21:03 volumio volumio[3518]: info: Loading plugin "appearance"... Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "network"... Aug 30 23:21:04 volumio volumio[3518]: info: Refreshing Cached IP Addresses Aug 30 23:21:04 volumio sudo[3547]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 23:21:04 volumio sudo[3547]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:04 volumio sudo[3547]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:04 volumio sudo[3549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 23:21:04 volumio sudo[3549]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:04 volumio sudo[3549]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "services"... Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "alsa_controller"... Aug 30 23:21:04 volumio sudo[3558]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 23:21:04 volumio sudo[3558]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:04 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "wizard"... Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "networkfs"... Aug 30 23:21:04 volumio volumio[3518]: info: Starting Udev Watcher for removable devices Aug 30 23:21:04 volumio volumio[3518]: info: Ignoring mount for partition: boot Aug 30 23:21:04 volumio volumio[3518]: info: Ignoring mount for partition: volumio Aug 30 23:21:04 volumio volumio[3518]: info: Ignoring mount for partition: volumio_data Aug 30 23:21:04 volumio volumio[3518]: info: Mounting Device USB_1 Aug 30 23:21:04 volumio sudo[3578]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:04 volumio sudo[3578]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:04 volumio sudo[3578]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:04 volumio volumio[3518]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:04 volumio volumio[3518]: error: Failed to mount USB_1: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/USB_1" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:04 volumio volumio[3518]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:04 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "volumio_command_line_client"... Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "upnp"... Aug 30 23:21:04 volumio volumio[3518]: info: [1756576264734] Starting Upmpd Daemon Aug 30 23:21:04 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "my_music"... Aug 30 23:21:04 volumio volumio[3518]: info: Loading plugin "mpd"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "upnp_browser"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "alarm-clock"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "airplay_emulation"... Aug 30 23:21:05 volumio volumio[3518]: info: Starting Shairport Sync Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "last_100"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "webradio"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "i2s_dacs"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "volumiodiscovery"... Aug 30 23:21:05 volumio volumio[3518]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:05 volumio volumio[3518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:05 volumio volumio[3518]: *** WARNING *** For more information see Aug 30 23:21:05 volumio volumio[3518]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:05 volumio node[3518]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:05 volumio volumio[3518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:05 volumio volumio[3518]: *** WARNING *** For more information see Aug 30 23:21:05 volumio node[3518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:05 volumio node[3518]: *** WARNING *** For more information see Aug 30 23:21:05 volumio node[3518]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:05 volumio node[3518]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:05 volumio node[3518]: *** WARNING *** For more information see Aug 30 23:21:05 volumio volumio[3518]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 23:21:05 volumio volumio[3518]: info: Discovery: Started advertising with name: Volumio Aug 30 23:21:05 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "outputs"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "albumart"... Aug 30 23:21:05 volumio volumio[3518]: info: Plugin example_plugin is not enabled Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "inputs"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "updater_comm"... Aug 30 23:21:05 volumio volumio[3518]: info: Plugin mpdemulation is not enabled Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "rest_api"... Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "websocket"... Aug 30 23:21:05 volumio volumio[3518]: info: Starting Socket.io Server version 2.3.0 Aug 30 23:21:05 volumio volumio[3518]: info: Loading plugin "fusiondsp"... Aug 30 23:21:06 volumio volumio-remote-updater[581]: [2025-08-30 23:21:06] [connect] Successful connection Aug 30 23:21:06 volumio volumio[3518]: Forking 3 albumart workers Aug 30 23:21:06 volumio volumio[3518]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 23:21:06 volumio volumio[3518]: info: Loading i18n strings for locale en Aug 30 23:21:06 volumio volumio[3518]: Updating browse sources language Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::initPlayerControls Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:06 volumio volumio[3518]: Express server listening on port 3000 Aug 30 23:21:06 volumio volumio[3518]: [Metrics] WebUI: 4s 412.20ms Aug 30 23:21:06 volumio volumio[3518]: info: CoreStateMachine::resetVolumioState Aug 30 23:21:06 volumio volumio[3518]: info: CoreStateMachine::getcurrentVolume Aug 30 23:21:06 volumio volumio[3518]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:06 volumio volumio[3518]: info: Cannot read play queue from file Aug 30 23:21:06 volumio volumio[3518]: info: Volumio Network Manager: Network status updated: 2 Aug 30 23:21:06 volumio volumio[3518]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Aug 30 23:21:06 volumio volumio[3518]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Aug 30 23:21:06 volumio volumio[3518]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Aug 30 23:21:06 volumio volumio-remote-updater[581]: [2025-08-30 23:21:06] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756576266 101 Aug 30 23:21:06 volumio volumio[3518]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 4 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:07 volumio volumio[3518]: info: Executing start script for DAC IQaudIO DAC Plus Aug 30 23:21:07 volumio volumio[3518]: info: CoreStateMachine::setRepeat null single undefined Aug 30 23:21:07 volumio volumio[3518]: info: CoreStateMachine::pushState Aug 30 23:21:07 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:07 volumio volumio[3518]: Starting albumart workers Aug 30 23:21:07 volumio volumio[3518]: info: CoreStateMachine::setRandom null Aug 30 23:21:07 volumio volumio[3518]: info: CoreStateMachine::pushState Aug 30 23:21:07 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:07 volumio volumio[3518]: info: Setting Device type: Raspberry PI Aug 30 23:21:07 volumio volumio[3518]: Starting albumart workers Aug 30 23:21:07 volumio volumio[3518]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:07 volumio volumio[3518]: info: CoreStateMachine::pushState Aug 30 23:21:07 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:07 volumio volumio[3518]: info: CoreStateMachine::updateTrackBlock Aug 30 23:21:07 volumio volumio[3518]: info: CorePlayQueue::getTrackBlock Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:07 volumio volumio[3518]: Starting albumart workers Aug 30 23:21:07 volumio volumio[3518]: info: DAC script executed Aug 30 23:21:07 volumio volumio[3518]: info: Completed loading Core Plugins Aug 30 23:21:07 volumio volumio[3518]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:07 volumio volumio[3518]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:07 volumio volumio[3518]: info: Reading ALSA contributions from plugins. Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:07 volumio volumio[3518]: info: Discovery: Getting this device information Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:07 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:07 volumio volumio[3518]: info: Discovery: adding a86aa518-ea14-4ca7-8ab5-e77925c9a66a Aug 30 23:21:07 volumio volumio[3518]: info: Discovery: Found device Volumio Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:07 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:07 volumio volumio[3518]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:07 volumio volumio[3518]: info: CoreStateMachine::pushState Aug 30 23:21:07 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:07 volumio volumio[3518]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:07 volumio volumio[3518]: info: Output device has changed, restarting MPD Aug 30 23:21:07 volumio sudo[3627]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:07 volumio sudo[3627]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:07 volumio volumio[3518]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:07 volumio sudo[3627]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:07 volumio sudo[3630]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:07 volumio sudo[3630]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:07 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 23:21:07 volumio volumio[3518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:07 volumio volumio[3518]: info: ___________ START PLUGINS ___________ Aug 30 23:21:07 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:07 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:07 volumio volumio[3518]: info: ControllerMpd::onStart: Initializing MPD Aug 30 23:21:07 volumio volumio[3518]: info: Creating MPD Configuration file Aug 30 23:21:07 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:07 volumio sudo[3637]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:07 volumio sudo[3637]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:07 volumio sudo[3637]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:07 volumio volumio[3518]: info: [1756576267669] CoreMusicLibrary::Adding element Media Servers Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:07 volumio sudo[3640]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:07 volumio sudo[3640]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:07 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 23:21:07 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:07 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:07 volumio volumio[3518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:07 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:07 volumio volumio[3518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:07 volumio volumio[3518]: info: [1756576267943] CoreMusicLibrary::Adding element Last_100 Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:07 volumio volumio[3518]: info: [1756576267957] CoreMusicLibrary::Adding element Webradio Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:07 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:07 volumio volumio[3518]: info: Initializing BBC Radios Aug 30 23:21:07 volumio sudo[3647]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:07 volumio sudo[3647]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:08 volumio sudo[3647]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: Loading i18n strings for locale en Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 23:21:08 volumio volumio[3518]: info: Volumio Calling Home Aug 30 23:21:08 volumio sudo[3558]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:08 volumio volumio[3518]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:08 volumio volumio[3518]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:08 volumio volumio[3518]: info: Reading ALSA contributions from plugins. Aug 30 23:21:08 volumio volumio[3518]: info: MPD Permissions set Aug 30 23:21:08 volumio volumio[3518]: info: MPD Permissions set Aug 30 23:21:08 volumio volumio[3518]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 23:21:08 volumio volumio[3518]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:08 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 23:21:08 volumio volumio[3518]: info: Volumio called home Aug 30 23:21:08 volumio volumio[3518]: info: Starting Shairport Sync Aug 30 23:21:08 volumio volumio[3518]: info: Starting Shairport Sync Aug 30 23:21:08 volumio volumio[3518]: info: Starting Shairport Sync Aug 30 23:21:08 volumio sudo[3697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:08 volumio sudo[3697]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:08 volumio sudo[3699]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:08 volumio sudo[3699]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:08 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:08 volumio sudo[3703]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:08 volumio sudo[3703]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:08 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:08 volumio sudo[3697]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:08 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:08 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:08 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:08 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:08 volumio volumio[3518]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:08 volumio volumio[3518]: info: Output device has changed, restarting MPD Aug 30 23:21:08 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:08 volumio sudo[3699]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:08 volumio sudo[3703]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:08 volumio volumio[3518]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:08 volumio sudo[3708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:08 volumio sudo[3708]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:08 volumio sudo[3708]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:08 volumio sudo[3710]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:08 volumio sudo[3710]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:08 volumio volumio[3518]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:08 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:08 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:08 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:08 volumio volumio[3518]: info: Shairport-Sync Started Aug 30 23:21:08 volumio volumio[3518]: Error adding Membership: Error: addMembership EINVAL Aug 30 23:21:08 volumio volumio[3518]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Aug 30 23:21:08 volumio volumio[3518]: info: MPD Permissions set Aug 30 23:21:08 volumio volumio[3518]: info: Shairport-Sync Started Aug 30 23:21:08 volumio volumio[3518]: info: Shairport-Sync Started Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:08 volumio volumio[3518]: info: Starting Shairport Sync Aug 30 23:21:08 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 30 23:21:09 volumio sudo[3724]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:09 volumio sudo[3724]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 23:21:09 volumio volumio[3518]: info: Received Get System Info Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:09 volumio volumio[3518]: info: Discovery: Getting this device information Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:09 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 23:21:09 volumio volumio[3518]: info: Received Get System Info Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:09 volumio volumio[3518]: info: Discovery: Getting this device information Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:09 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:09 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:09 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:09 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:09 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:09 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 23:21:09 volumio sudo[3724]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:09 volumio volumio[3518]: info: Received Get System Info Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:09 volumio volumio[3518]: info: Discovery: Getting this device information Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:09 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:09 volumio volumio[3518]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:09 volumio volumio[3518]: info: Listing playlists Aug 30 23:21:09 volumio volumio[3518]: info: Shairport-Sync Started Aug 30 23:21:09 volumio sudo[3718]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:09 volumio sudo[3718]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:09 volumio sudo[3718]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:21:09 volumio volumio[3518]: info: FusionDsp - Aug 30 23:21:09 volumio volumio[3518]: info: FusionDsp - Aug 30 23:21:09 volumio volumio[3518]: info: FusionDsp - undefined Aug 30 23:21:09 volumio volumio[3518]: info: FusionDsp - undefined Aug 30 23:21:09 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 23:21:10 volumio volumio[3518]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:10 volumio volumio[3518]: 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 Aug 30 23:21:10 volumio volumio[3518]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:10 volumio volumio[3518]: info: camilladsp service started and running in background, instance 1 Aug 30 23:21:10 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:10 volumio volumio[3518]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:10 volumio volumio[3518]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 23:21:10 volumio volumio[3518]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:10 volumio volumio[3518]: info: FusionDsp loaded Aug 30 23:21:10 volumio volumio[3518]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:10 volumio sudo[3742]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 23:21:10 volumio sudo[3742]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:10 volumio volumio[3518]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 23:21:10 volumio volumio[3518]: info: Adding Signal Path Element [object Object] Aug 30 23:21:10 volumio volumio[3518]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 23:21:10 volumio sudo[3742]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:10 volumio volumio[3518]: info: FusionDsp - ---- installed callbackRead Aug 30 23:21:10 volumio volumio[3518]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:10 volumio volumio[3518]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 23:21:10 volumio volumio[3518]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 23:21:10 volumio volumio[3518]: at onErrorNT (internal/child_process.js:465:16) Aug 30 23:21:10 volumio volumio[3518]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 23:21:10 volumio volumio[3518]: errno: -2, Aug 30 23:21:10 volumio volumio[3518]: code: 'ENOENT', Aug 30 23:21:10 volumio volumio[3518]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:10 volumio volumio[3518]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:10 volumio volumio[3518]: spawnargs: [ Aug 30 23:21:10 volumio volumio[3518]: '-p', Aug 30 23:21:10 volumio volumio[3518]: 9876, Aug 30 23:21:10 volumio volumio[3518]: '-o', Aug 30 23:21:10 volumio volumio[3518]: '/tmp/camilladsp.log', Aug 30 23:21:10 volumio volumio[3518]: '-l', Aug 30 23:21:10 volumio volumio[3518]: 'warn', Aug 30 23:21:10 volumio volumio[3518]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 23:21:10 volumio volumio[3518]: ] Aug 30 23:21:10 volumio volumio[3518]: } Aug 30 23:21:10 volumio volumio[3518]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:10 volumio mpd[3730]: Aug 30 23:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 23:21:10 volumio systemd[1]: Started Music Player Daemon. Aug 30 23:21:10 volumio sudo[3640]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:10 volumio sudo[3710]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:10 volumio sudo[3630]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:10 volumio sudo[3756]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 23:20 Aug 30 23:21:10 volumio sudo[3756]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:11 volumio sudo[3756]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:11 volumio volumio-remote-updater[581]: [2025-08-30 23:21:11] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 30 23:21:11 volumio volumio-remote-updater[581]: [2025-08-30 23:21:11] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 30 23:21:11 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 30 23:21:11 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 30 23:21:11 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:11 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:11 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 30 23:21:11 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 11. Aug 30 23:21:11 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:11 volumio systemd[1]: Stopped Volumio Backend Module. Aug 30 23:21:11 volumio systemd[1]: Started Volumio Backend Module. Aug 30 23:21:11 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:12 volumio volumio[3767]: info: ------------------------------------------- Aug 30 23:21:12 volumio volumio[3767]: info: ----- Volumio3 ---- Aug 30 23:21:12 volumio volumio[3767]: info: ------------------------------------------- Aug 30 23:21:12 volumio volumio[3767]: info: ----- System startup ---- Aug 30 23:21:12 volumio volumio[3767]: info: ------------------------------------------- Aug 30 23:21:13 volumio volumio[3767]: info: MYVOLUMIO Environment detected Aug 30 23:21:13 volumio volumio[3767]: info: Plugin folders cleanup Aug 30 23:21:13 volumio volumio[3767]: info: Scanning into folder /volumio/app/plugins/ Aug 30 23:21:13 volumio volumio[3767]: info: Scanning category audio_interface Aug 30 23:21:13 volumio volumio[3767]: info: Scanning category miscellanea Aug 30 23:21:13 volumio volumio[3767]: info: Scanning category music_service Aug 30 23:21:13 volumio volumio[3767]: info: Scanning category plugins.json Aug 30 23:21:13 volumio volumio[3767]: info: Scanning category system_controller Aug 30 23:21:13 volumio volumio[3767]: info: Scanning category user_interface Aug 30 23:21:13 volumio volumio[3767]: info: Scanning into folder /data/plugins/ Aug 30 23:21:13 volumio volumio[3767]: info: Scanning category audio_interface Aug 30 23:21:13 volumio volumio[3767]: info: Plugin folders cleanup completed Aug 30 23:21:13 volumio volumio[3767]: info: ------------------------------------------- Aug 30 23:21:13 volumio volumio[3767]: info: ----- Core plugins startup ---- Aug 30 23:21:13 volumio volumio[3767]: info: ------------------------------------------- Aug 30 23:21:13 volumio volumio[3767]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 23:21:13 volumio volumio[3767]: info: Adding plugin upnp to MyMusic Plugins Aug 30 23:21:13 volumio volumio[3767]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 23:21:13 volumio volumio[3767]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 23:21:13 volumio volumio[3767]: info: Loading plugins from folder /data/plugins/ Aug 30 23:21:13 volumio volumio[3767]: info: Loading plugin "system"... Aug 30 23:21:13 volumio volumio[3767]: info: Loading plugin "appearance"... Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "network"... Aug 30 23:21:14 volumio volumio[3767]: info: Refreshing Cached IP Addresses Aug 30 23:21:14 volumio sudo[3793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 23:21:14 volumio sudo[3793]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:14 volumio sudo[3793]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:14 volumio sudo[3795]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 23:21:14 volumio sudo[3795]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:14 volumio sudo[3795]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "services"... Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "alsa_controller"... Aug 30 23:21:14 volumio sudo[3805]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 23:21:14 volumio sudo[3805]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:14 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "wizard"... Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "networkfs"... Aug 30 23:21:14 volumio volumio[3767]: info: Starting Udev Watcher for removable devices Aug 30 23:21:14 volumio volumio[3767]: info: Ignoring mount for partition: boot Aug 30 23:21:14 volumio volumio[3767]: info: Ignoring mount for partition: volumio Aug 30 23:21:14 volumio volumio[3767]: info: Ignoring mount for partition: volumio_data Aug 30 23:21:14 volumio volumio[3767]: info: Mounting Device USB_1 Aug 30 23:21:14 volumio sudo[3824]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:14 volumio sudo[3824]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:14 volumio sudo[3824]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:14 volumio volumio[3767]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:14 volumio volumio[3767]: error: Failed to mount USB_1: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/USB_1" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:14 volumio volumio[3767]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:14 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "volumio_command_line_client"... Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "upnp"... Aug 30 23:21:14 volumio volumio[3767]: info: [1756576274910] Starting Upmpd Daemon Aug 30 23:21:14 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "my_music"... Aug 30 23:21:14 volumio volumio[3767]: info: Loading plugin "mpd"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "upnp_browser"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "alarm-clock"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "airplay_emulation"... Aug 30 23:21:15 volumio volumio[3767]: info: Starting Shairport Sync Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "last_100"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "webradio"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "i2s_dacs"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "volumiodiscovery"... Aug 30 23:21:15 volumio volumio[3767]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:15 volumio volumio[3767]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:15 volumio volumio[3767]: *** WARNING *** For more information see Aug 30 23:21:15 volumio node[3767]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:15 volumio volumio[3767]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:15 volumio volumio[3767]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:15 volumio volumio[3767]: *** WARNING *** For more information see Aug 30 23:21:15 volumio node[3767]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:15 volumio node[3767]: *** WARNING *** For more information see Aug 30 23:21:15 volumio node[3767]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:15 volumio node[3767]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:15 volumio node[3767]: *** WARNING *** For more information see Aug 30 23:21:15 volumio volumio[3767]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 23:21:15 volumio volumio[3767]: info: Discovery: Started advertising with name: Volumio Aug 30 23:21:15 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "outputs"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "albumart"... Aug 30 23:21:15 volumio volumio[3767]: info: Plugin example_plugin is not enabled Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "inputs"... Aug 30 23:21:15 volumio volumio[3767]: info: Loading plugin "updater_comm"... Aug 30 23:21:16 volumio volumio[3767]: info: Plugin mpdemulation is not enabled Aug 30 23:21:16 volumio volumio[3767]: info: Loading plugin "rest_api"... Aug 30 23:21:16 volumio volumio-remote-updater[581]: [2025-08-30 23:21:16] [connect] Successful connection Aug 30 23:21:16 volumio volumio[3767]: info: Loading plugin "websocket"... Aug 30 23:21:16 volumio volumio[3767]: info: Starting Socket.io Server version 2.3.0 Aug 30 23:21:16 volumio volumio[3767]: info: Loading plugin "fusiondsp"... Aug 30 23:21:16 volumio volumio[3767]: Forking 3 albumart workers Aug 30 23:21:16 volumio volumio[3767]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 23:21:16 volumio volumio[3767]: info: Loading i18n strings for locale en Aug 30 23:21:16 volumio volumio[3767]: Updating browse sources language Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::initPlayerControls Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:16 volumio volumio[3767]: Express server listening on port 3000 Aug 30 23:21:16 volumio volumio[3767]: [Metrics] WebUI: 4s 516.10ms Aug 30 23:21:16 volumio volumio[3767]: info: CoreStateMachine::resetVolumioState Aug 30 23:21:16 volumio volumio[3767]: info: CoreStateMachine::getcurrentVolume Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:17 volumio volumio[3767]: info: Cannot read play queue from file Aug 30 23:21:17 volumio volumio[3767]: info: Volumio Network Manager: Network status updated: 2 Aug 30 23:21:17 volumio volumio[3767]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Aug 30 23:21:17 volumio volumio[3767]: Starting albumart workers Aug 30 23:21:17 volumio volumio[3767]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 2 Aug 30 23:21:17 volumio volumio-remote-updater[581]: [2025-08-30 23:21:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756576276 101 Aug 30 23:21:17 volumio volumio[3767]: 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 Aug 30 23:21:17 volumio volumio[3767]: Starting albumart workers Aug 30 23:21:17 volumio volumio[3767]: Starting albumart workers Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:17 volumio volumio[3767]: info: Discovery: Getting this device information Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:17 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:17 volumio volumio[3767]: info: Executing start script for DAC IQaudIO DAC Plus Aug 30 23:21:17 volumio volumio[3767]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:17 volumio volumio[3767]: info: CoreStateMachine::pushState Aug 30 23:21:17 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:17 volumio volumio[3767]: info: CoreStateMachine::updateTrackBlock Aug 30 23:21:17 volumio volumio[3767]: info: CorePlayQueue::getTrackBlock Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:17 volumio volumio[3767]: info: CoreStateMachine::setRepeat null single undefined Aug 30 23:21:17 volumio volumio[3767]: info: CoreStateMachine::pushState Aug 30 23:21:17 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:17 volumio volumio[3767]: info: CoreStateMachine::setRandom null Aug 30 23:21:17 volumio volumio[3767]: info: CoreStateMachine::pushState Aug 30 23:21:17 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:17 volumio volumio[3767]: info: Setting Device type: Raspberry PI Aug 30 23:21:17 volumio volumio[3767]: info: DAC script executed Aug 30 23:21:17 volumio volumio[3767]: info: Completed loading Core Plugins Aug 30 23:21:17 volumio volumio[3767]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:17 volumio volumio[3767]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:17 volumio volumio[3767]: info: Reading ALSA contributions from plugins. Aug 30 23:21:17 volumio volumio[3767]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 30 23:21:17 volumio volumio[3767]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 23:21:17 volumio volumio[3767]: info: Discovery: adding a86aa518-ea14-4ca7-8ab5-e77925c9a66a Aug 30 23:21:17 volumio volumio[3767]: info: Discovery: Found device Volumio Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:17 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:17 volumio volumio[3767]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:17 volumio volumio[3767]: info: Output device has changed, restarting MPD Aug 30 23:21:17 volumio volumio[3767]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:17 volumio sudo[3873]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:17 volumio sudo[3873]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:17 volumio sudo[3873]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:17 volumio sudo[3875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:17 volumio sudo[3875]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:17 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 23:21:17 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:17 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:17 volumio volumio[3767]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:17 volumio volumio[3767]: info: ___________ START PLUGINS ___________ Aug 30 23:21:17 volumio volumio[3767]: info: ControllerMpd::onStart: Initializing MPD Aug 30 23:21:17 volumio volumio[3767]: info: Creating MPD Configuration file Aug 30 23:21:17 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:17 volumio sudo[3883]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:17 volumio sudo[3883]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:17 volumio sudo[3883]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:17 volumio volumio[3767]: info: [1756576277952] CoreMusicLibrary::Adding element Media Servers Aug 30 23:21:17 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:17 volumio sudo[3886]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:17 volumio sudo[3886]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:18 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 23:21:18 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:18 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:18 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:18 volumio volumio[3767]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:18 volumio volumio[3767]: info: [1756576278186] CoreMusicLibrary::Adding element Last_100 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:18 volumio volumio[3767]: info: [1756576278191] CoreMusicLibrary::Adding element Webradio Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:18 volumio volumio[3767]: info: Initializing BBC Radios Aug 30 23:21:18 volumio sudo[3897]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:18 volumio sudo[3897]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:18 volumio sudo[3897]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: Loading i18n strings for locale en Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 23:21:18 volumio volumio[3767]: info: Volumio Calling Home Aug 30 23:21:18 volumio volumio[3767]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:18 volumio sudo[3805]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:18 volumio volumio[3767]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:18 volumio volumio[3767]: info: Reading ALSA contributions from plugins. Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:18 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 23:21:18 volumio volumio[3767]: info: MPD Permissions set Aug 30 23:21:18 volumio volumio[3767]: info: MPD Permissions set Aug 30 23:21:18 volumio volumio[3767]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:18 volumio volumio[3767]: info: CoreStateMachine::pushState Aug 30 23:21:18 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:18 volumio volumio[3767]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:18 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 23:21:18 volumio volumio[3767]: info: Received Get System Info Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:18 volumio volumio[3767]: info: Discovery: Getting this device information Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:18 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:18 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:18 volumio volumio[3767]: info: Listing playlists Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 23:21:18 volumio volumio[3767]: info: CALLMETHOD: system_controller my_volumio retreiveBackendEventStates undefined Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: my_volumio , retreiveBackendEventStates Aug 30 23:21:18 volumio volumio[3767]: info: Received Get System Version Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:18 volumio volumio[3767]: info: Received Get System Info Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:18 volumio volumio[3767]: info: Discovery: Getting this device information Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:18 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:18 volumio volumio[3767]: info: Volumio called home Aug 30 23:21:18 volumio volumio[3767]: info: Starting Shairport Sync Aug 30 23:21:18 volumio volumio[3767]: info: Starting Shairport Sync Aug 30 23:21:18 volumio volumio[3767]: info: Starting Shairport Sync Aug 30 23:21:18 volumio sudo[3943]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:18 volumio sudo[3943]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:18 volumio sudo[3945]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:18 volumio sudo[3945]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:18 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:18 volumio sudo[3948]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:18 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:18 volumio sudo[3948]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:18 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:19 volumio sudo[3943]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:19 volumio sudo[3945]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:19 volumio volumio[3767]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:19 volumio volumio[3767]: info: Output device has changed, restarting MPD Aug 30 23:21:19 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:19 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:19 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:19 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:19 volumio sudo[3948]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:19 volumio sudo[3954]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:19 volumio sudo[3954]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:19 volumio sudo[3954]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:19 volumio volumio[3767]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:19 volumio sudo[3958]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:19 volumio sudo[3958]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:19 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:19 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:19 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:19 volumio volumio[3767]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:21:19 volumio volumio[3767]: info: Shairport-Sync Started Aug 30 23:21:19 volumio volumio[3767]: Error adding Membership: Error: addMembership EINVAL Aug 30 23:21:19 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:19 volumio volumio[3767]: info: MPD Permissions set Aug 30 23:21:19 volumio volumio[3767]: info: Shairport-Sync Started Aug 30 23:21:19 volumio volumio[3767]: info: Shairport-Sync Started Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:19 volumio volumio[3767]: info: FusionDsp - Aug 30 23:21:19 volumio sudo[3964]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:19 volumio sudo[3964]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:19 volumio sudo[3964]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:19 volumio volumio[3767]: info: FusionDsp - Aug 30 23:21:19 volumio volumio[3767]: info: FusionDsp - Aug 30 23:21:19 volumio volumio[3767]: info: FusionDsp - undefined Aug 30 23:21:20 volumio volumio[3767]: info: FusionDsp - undefined Aug 30 23:21:20 volumio volumio[3767]: info: FusionDsp - undefined Aug 30 23:21:20 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:20 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:20 volumio volumio[3767]: info: Discovery: Getting this device information Aug 30 23:21:20 volumio volumio[3767]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:20 volumio volumio[3767]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:20 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:20 volumio volumio[3767]: info: Starting Shairport Sync Aug 30 23:21:20 volumio sudo[3974]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:20 volumio sudo[3974]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:20 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:20 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:20 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:20 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:20 volumio volumio[3767]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:20 volumio volumio[3767]: 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 Aug 30 23:21:20 volumio volumio[3767]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:20 volumio sudo[3974]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:20 volumio volumio[3767]: info: camilladsp service started and running in background, instance 1 Aug 30 23:21:20 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:20 volumio volumio[3767]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:20 volumio volumio[3767]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 23:21:20 volumio volumio[3767]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:20 volumio volumio[3767]: info: FusionDsp loaded Aug 30 23:21:20 volumio volumio[3767]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:20 volumio sudo[3989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 23:21:20 volumio sudo[3989]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:20 volumio volumio[3767]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 23:21:20 volumio volumio[3767]: info: Adding Signal Path Element [object Object] Aug 30 23:21:20 volumio volumio[3767]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 23:21:20 volumio volumio[3767]: info: FusionDsp - ---- installed callbackRead Aug 30 23:21:20 volumio volumio[3767]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:20 volumio sudo[3989]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:20 volumio volumio[3767]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 23:21:20 volumio volumio[3767]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 23:21:20 volumio volumio[3767]: at onErrorNT (internal/child_process.js:465:16) Aug 30 23:21:20 volumio volumio[3767]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Aug 30 23:21:20 volumio volumio[3767]: at runNextTicks (internal/process/task_queues.js:62:3) Aug 30 23:21:20 volumio volumio[3767]: at listOnTimeout (internal/timers.js:523:9) Aug 30 23:21:20 volumio volumio[3767]: at processTimers (internal/timers.js:497:7) { Aug 30 23:21:20 volumio volumio[3767]: errno: -2, Aug 30 23:21:20 volumio volumio[3767]: code: 'ENOENT', Aug 30 23:21:20 volumio volumio[3767]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:20 volumio volumio[3767]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:20 volumio volumio[3767]: spawnargs: [ Aug 30 23:21:20 volumio volumio[3767]: '-p', Aug 30 23:21:20 volumio volumio[3767]: 9876, Aug 30 23:21:20 volumio volumio[3767]: '-o', Aug 30 23:21:20 volumio volumio[3767]: '/tmp/camilladsp.log', Aug 30 23:21:20 volumio volumio[3767]: '-l', Aug 30 23:21:20 volumio volumio[3767]: 'warn', Aug 30 23:21:20 volumio volumio[3767]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 23:21:20 volumio volumio[3767]: ] Aug 30 23:21:20 volumio volumio[3767]: } Aug 30 23:21:20 volumio volumio[3767]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:20 volumio mpd[3971]: Aug 30 23:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 23:21:20 volumio systemd[1]: Started Music Player Daemon. Aug 30 23:21:20 volumio sudo[3875]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:20 volumio sudo[3958]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:20 volumio sudo[3886]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:21 volumio sudo[4002]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 23:20 Aug 30 23:21:21 volumio sudo[4002]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:21 volumio sudo[4002]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:21 volumio volumio-remote-updater[581]: [2025-08-30 23:21:21] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 30 23:21:21 volumio volumio-remote-updater[581]: [2025-08-30 23:21:21] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 30 23:21:21 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 30 23:21:21 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 30 23:21:21 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:21 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:21 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 30 23:21:21 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Aug 30 23:21:21 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:21 volumio systemd[1]: Stopped Volumio Backend Module. Aug 30 23:21:21 volumio systemd[1]: Started Volumio Backend Module. Aug 30 23:21:21 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:23 volumio volumio[4016]: info: ------------------------------------------- Aug 30 23:21:23 volumio volumio[4016]: info: ----- Volumio3 ---- Aug 30 23:21:23 volumio volumio[4016]: info: ------------------------------------------- Aug 30 23:21:23 volumio volumio[4016]: info: ----- System startup ---- Aug 30 23:21:23 volumio volumio[4016]: info: ------------------------------------------- Aug 30 23:21:23 volumio volumio[4016]: info: MYVOLUMIO Environment detected Aug 30 23:21:23 volumio volumio[4016]: info: Plugin folders cleanup Aug 30 23:21:23 volumio volumio[4016]: info: Scanning into folder /volumio/app/plugins/ Aug 30 23:21:23 volumio volumio[4016]: info: Scanning category audio_interface Aug 30 23:21:23 volumio volumio[4016]: info: Scanning category miscellanea Aug 30 23:21:23 volumio volumio[4016]: info: Scanning category music_service Aug 30 23:21:23 volumio volumio[4016]: info: Scanning category plugins.json Aug 30 23:21:23 volumio volumio[4016]: info: Scanning category system_controller Aug 30 23:21:23 volumio volumio[4016]: info: Scanning category user_interface Aug 30 23:21:23 volumio volumio[4016]: info: Scanning into folder /data/plugins/ Aug 30 23:21:23 volumio volumio[4016]: info: Scanning category audio_interface Aug 30 23:21:23 volumio volumio[4016]: info: Plugin folders cleanup completed Aug 30 23:21:23 volumio volumio[4016]: info: ------------------------------------------- Aug 30 23:21:23 volumio volumio[4016]: info: ----- Core plugins startup ---- Aug 30 23:21:23 volumio volumio[4016]: info: ------------------------------------------- Aug 30 23:21:23 volumio volumio[4016]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 23:21:23 volumio volumio[4016]: info: Adding plugin upnp to MyMusic Plugins Aug 30 23:21:23 volumio volumio[4016]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 23:21:23 volumio volumio[4016]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 23:21:23 volumio volumio[4016]: info: Loading plugins from folder /data/plugins/ Aug 30 23:21:23 volumio volumio[4016]: info: Loading plugin "system"... Aug 30 23:21:23 volumio volumio[4016]: info: Loading plugin "appearance"... Aug 30 23:21:24 volumio volumio[4016]: info: Loading plugin "network"... Aug 30 23:21:24 volumio volumio[4016]: info: Refreshing Cached IP Addresses Aug 30 23:21:24 volumio sudo[4042]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 23:21:24 volumio sudo[4042]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:24 volumio sudo[4042]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:24 volumio sudo[4044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 23:21:24 volumio sudo[4044]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:24 volumio sudo[4044]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:24 volumio volumio[4016]: info: Loading plugin "services"... Aug 30 23:21:24 volumio volumio[4016]: info: Loading plugin "alsa_controller"... Aug 30 23:21:24 volumio sudo[4053]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 23:21:24 volumio sudo[4053]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:25 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "wizard"... Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "networkfs"... Aug 30 23:21:25 volumio volumio[4016]: info: Starting Udev Watcher for removable devices Aug 30 23:21:25 volumio volumio[4016]: info: Ignoring mount for partition: boot Aug 30 23:21:25 volumio volumio[4016]: info: Ignoring mount for partition: volumio Aug 30 23:21:25 volumio volumio[4016]: info: Ignoring mount for partition: volumio_data Aug 30 23:21:25 volumio volumio[4016]: info: Mounting Device USB_1 Aug 30 23:21:25 volumio sudo[4073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:25 volumio sudo[4073]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:25 volumio sudo[4073]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:25 volumio volumio[4016]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:25 volumio volumio[4016]: error: Failed to mount USB_1: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/USB_1" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:25 volumio volumio[4016]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:25 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "volumio_command_line_client"... Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "upnp"... Aug 30 23:21:25 volumio volumio[4016]: info: [1756576285164] Starting Upmpd Daemon Aug 30 23:21:25 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "my_music"... Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "mpd"... Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "upnp_browser"... Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "alarm-clock"... Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "airplay_emulation"... Aug 30 23:21:25 volumio volumio[4016]: info: Starting Shairport Sync Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "last_100"... Aug 30 23:21:25 volumio volumio[4016]: info: Loading plugin "webradio"... Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "i2s_dacs"... Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "volumiodiscovery"... Aug 30 23:21:26 volumio volumio[4016]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:26 volumio volumio[4016]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:26 volumio volumio[4016]: *** WARNING *** For more information see Aug 30 23:21:26 volumio node[4016]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:26 volumio volumio[4016]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:26 volumio volumio[4016]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:26 volumio volumio[4016]: *** WARNING *** For more information see Aug 30 23:21:26 volumio node[4016]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:26 volumio node[4016]: *** WARNING *** For more information see Aug 30 23:21:26 volumio node[4016]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:26 volumio node[4016]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:26 volumio node[4016]: *** WARNING *** For more information see Aug 30 23:21:26 volumio volumio[4016]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 23:21:26 volumio volumio[4016]: info: Discovery: Started advertising with name: Volumio Aug 30 23:21:26 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "outputs"... Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "albumart"... Aug 30 23:21:26 volumio volumio[4016]: info: Plugin example_plugin is not enabled Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "inputs"... Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "updater_comm"... Aug 30 23:21:26 volumio volumio[4016]: info: Plugin mpdemulation is not enabled Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "rest_api"... Aug 30 23:21:26 volumio volumio-remote-updater[581]: [2025-08-30 23:21:26] [connect] Successful connection Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "websocket"... Aug 30 23:21:26 volumio volumio[4016]: info: Starting Socket.io Server version 2.3.0 Aug 30 23:21:26 volumio volumio[4016]: info: Loading plugin "fusiondsp"... Aug 30 23:21:26 volumio volumio[4016]: Forking 3 albumart workers Aug 30 23:21:26 volumio volumio[4016]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 23:21:26 volumio volumio[4016]: info: Loading i18n strings for locale en Aug 30 23:21:26 volumio volumio[4016]: Updating browse sources language Aug 30 23:21:26 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::initPlayerControls Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: Express server listening on port 3000 Aug 30 23:21:27 volumio volumio[4016]: [Metrics] WebUI: 4s 475.97ms Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::resetVolumioState Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::getcurrentVolume Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:27 volumio volumio[4016]: info: Cannot read play queue from file Aug 30 23:21:27 volumio volumio[4016]: info: Volumio Network Manager: Network status updated: 2 Aug 30 23:21:27 volumio volumio[4016]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Aug 30 23:21:27 volumio volumio[4016]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Aug 30 23:21:27 volumio volumio-remote-updater[581]: [2025-08-30 23:21:27] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756576286 101 Aug 30 23:21:27 volumio volumio[4016]: 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 Aug 30 23:21:27 volumio volumio[4016]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:27 volumio volumio[4016]: info: Discovery: Getting this device information Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:27 volumio volumio[4016]: Starting albumart workers Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:27 volumio volumio[4016]: Starting albumart workers Aug 30 23:21:27 volumio volumio[4016]: Starting albumart workers Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:27 volumio volumio[4016]: info: Executing start script for DAC IQaudIO DAC Plus Aug 30 23:21:27 volumio volumio[4016]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::pushState Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::updateTrackBlock Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrackBlock Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:27 volumio volumio[4016]: info: Setting Device type: Raspberry PI Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::setRepeat null single undefined Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::pushState Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::setRandom null Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::pushState Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:27 volumio volumio[4016]: info: DAC script executed Aug 30 23:21:27 volumio volumio[4016]: info: Completed loading Core Plugins Aug 30 23:21:27 volumio volumio[4016]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:27 volumio volumio[4016]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Aug 30 23:21:27 volumio volumio[4016]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:27 volumio volumio[4016]: info: Reading ALSA contributions from plugins. Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 23:21:27 volumio volumio[4016]: info: Discovery: adding a86aa518-ea14-4ca7-8ab5-e77925c9a66a Aug 30 23:21:27 volumio volumio[4016]: info: Discovery: Found device Volumio Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:27 volumio volumio[4016]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:27 volumio volumio[4016]: info: CoreStateMachine::pushState Aug 30 23:21:27 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:27 volumio volumio[4016]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:28 volumio volumio[4016]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:28 volumio volumio[4016]: info: Output device has changed, restarting MPD Aug 30 23:21:28 volumio volumio[4016]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:28 volumio sudo[4122]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:28 volumio sudo[4122]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:28 volumio sudo[4122]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:28 volumio sudo[4124]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:28 volumio sudo[4124]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:28 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 23:21:28 volumio volumio[4016]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:28 volumio volumio[4016]: info: ___________ START PLUGINS ___________ Aug 30 23:21:28 volumio volumio[4016]: info: ControllerMpd::onStart: Initializing MPD Aug 30 23:21:28 volumio volumio[4016]: info: Creating MPD Configuration file Aug 30 23:21:28 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:28 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:28 volumio volumio[4016]: info: [1756576288252] CoreMusicLibrary::Adding element Media Servers Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:28 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:28 volumio sudo[4132]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:28 volumio sudo[4132]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:28 volumio sudo[4134]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:28 volumio sudo[4134]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:28 volumio sudo[4132]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:28 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 23:21:28 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:28 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:28 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:28 volumio volumio[4016]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:28 volumio volumio[4016]: info: [1756576288457] CoreMusicLibrary::Adding element Last_100 Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:28 volumio volumio[4016]: info: [1756576288462] CoreMusicLibrary::Adding element Webradio Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:28 volumio volumio[4016]: info: Initializing BBC Radios Aug 30 23:21:28 volumio sudo[4137]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:28 volumio sudo[4137]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:28 volumio sudo[4137]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: Loading i18n strings for locale en Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 23:21:28 volumio volumio[4016]: info: Volumio Calling Home Aug 30 23:21:28 volumio sudo[4053]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:28 volumio volumio[4016]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:28 volumio volumio[4016]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:28 volumio volumio[4016]: info: Reading ALSA contributions from plugins. Aug 30 23:21:28 volumio volumio[4016]: info: MPD Permissions set Aug 30 23:21:28 volumio volumio[4016]: info: MPD Permissions set Aug 30 23:21:28 volumio volumio[4016]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:28 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: Volumio called home Aug 30 23:21:29 volumio volumio[4016]: info: Starting Shairport Sync Aug 30 23:21:29 volumio volumio[4016]: info: Starting Shairport Sync Aug 30 23:21:29 volumio volumio[4016]: info: Starting Shairport Sync Aug 30 23:21:29 volumio sudo[4192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:29 volumio sudo[4192]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:29 volumio sudo[4194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:29 volumio sudo[4194]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:29 volumio sudo[4197]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:29 volumio sudo[4197]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:29 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:29 volumio volumio[4016]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:29 volumio sudo[4192]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:29 volumio sudo[4194]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:29 volumio volumio[4016]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:29 volumio volumio[4016]: info: Output device has changed, restarting MPD Aug 30 23:21:29 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:29 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:29 volumio sudo[4197]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:29 volumio sudo[4203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:29 volumio sudo[4203]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:29 volumio sudo[4203]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:29 volumio volumio[4016]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:29 volumio sudo[4206]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:29 volumio sudo[4206]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:29 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:29 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:29 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:29 volumio volumio[4016]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:29 volumio volumio[4016]: info: Shairport-Sync Started Aug 30 23:21:29 volumio volumio[4016]: Error adding Membership: Error: addMembership EINVAL Aug 30 23:21:29 volumio volumio[4016]: info: Shairport-Sync Started Aug 30 23:21:29 volumio volumio[4016]: info: MPD Permissions set Aug 30 23:21:29 volumio volumio[4016]: info: Shairport-Sync Started Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:29 volumio volumio[4016]: info: Starting Shairport Sync Aug 30 23:21:29 volumio sudo[4219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:29 volumio sudo[4219]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:29 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:29 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:29 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:29 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:29 volumio sudo[4219]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:29 volumio volumio[4016]: info: Shairport-Sync Started Aug 30 23:21:29 volumio sudo[4213]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:29 volumio sudo[4213]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:29 volumio sudo[4213]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:30 volumio volumio[4016]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:30 volumio volumio[4016]: 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 Aug 30 23:21:30 volumio volumio[4016]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:30 volumio volumio[4016]: info: camilladsp service started and running in background, instance 1 Aug 30 23:21:30 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:30 volumio volumio[4016]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:30 volumio volumio[4016]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 23:21:30 volumio volumio[4016]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:30 volumio volumio[4016]: info: FusionDsp loaded Aug 30 23:21:30 volumio volumio[4016]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:30 volumio sudo[4237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 23:21:30 volumio sudo[4237]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:30 volumio volumio[4016]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 23:21:30 volumio volumio[4016]: info: Adding Signal Path Element [object Object] Aug 30 23:21:30 volumio volumio[4016]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 23:21:30 volumio volumio[4016]: info: FusionDsp - ---- installed callbackRead Aug 30 23:21:30 volumio volumio[4016]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:30 volumio sudo[4237]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:30 volumio volumio[4016]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 23:21:30 volumio volumio[4016]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 23:21:30 volumio volumio[4016]: at onErrorNT (internal/child_process.js:465:16) Aug 30 23:21:30 volumio volumio[4016]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 23:21:30 volumio volumio[4016]: errno: -2, Aug 30 23:21:30 volumio volumio[4016]: code: 'ENOENT', Aug 30 23:21:30 volumio volumio[4016]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:30 volumio volumio[4016]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:30 volumio volumio[4016]: spawnargs: [ Aug 30 23:21:30 volumio volumio[4016]: '-p', Aug 30 23:21:30 volumio volumio[4016]: 9876, Aug 30 23:21:30 volumio volumio[4016]: '-o', Aug 30 23:21:30 volumio volumio[4016]: '/tmp/camilladsp.log', Aug 30 23:21:30 volumio volumio[4016]: '-l', Aug 30 23:21:30 volumio volumio[4016]: 'warn', Aug 30 23:21:30 volumio volumio[4016]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 23:21:30 volumio volumio[4016]: ] Aug 30 23:21:30 volumio volumio[4016]: } Aug 30 23:21:30 volumio volumio[4016]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:30 volumio mpd[4224]: Aug 30 23:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 23:21:30 volumio systemd[1]: Started Music Player Daemon. Aug 30 23:21:30 volumio sudo[4206]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:30 volumio sudo[4134]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:30 volumio sudo[4124]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:31 volumio sudo[4250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 23:20 Aug 30 23:21:31 volumio sudo[4250]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:31 volumio sudo[4250]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:31 volumio volumio-remote-updater[581]: [2025-08-30 23:21:31] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 30 23:21:31 volumio volumio-remote-updater[581]: [2025-08-30 23:21:31] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 30 23:21:31 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 30 23:21:31 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 30 23:21:31 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:31 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:31 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 30 23:21:31 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13. Aug 30 23:21:31 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:31 volumio systemd[1]: Stopped Volumio Backend Module. Aug 30 23:21:31 volumio systemd[1]: Started Volumio Backend Module. Aug 30 23:21:31 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:33 volumio volumio[4261]: info: ------------------------------------------- Aug 30 23:21:33 volumio volumio[4261]: info: ----- Volumio3 ---- Aug 30 23:21:33 volumio volumio[4261]: info: ------------------------------------------- Aug 30 23:21:33 volumio volumio[4261]: info: ----- System startup ---- Aug 30 23:21:33 volumio volumio[4261]: info: ------------------------------------------- Aug 30 23:21:34 volumio volumio[4261]: info: MYVOLUMIO Environment detected Aug 30 23:21:34 volumio volumio[4261]: info: Plugin folders cleanup Aug 30 23:21:34 volumio volumio[4261]: info: Scanning into folder /volumio/app/plugins/ Aug 30 23:21:34 volumio volumio[4261]: info: Scanning category audio_interface Aug 30 23:21:34 volumio volumio[4261]: info: Scanning category miscellanea Aug 30 23:21:34 volumio volumio[4261]: info: Scanning category music_service Aug 30 23:21:34 volumio volumio[4261]: info: Scanning category plugins.json Aug 30 23:21:34 volumio volumio[4261]: info: Scanning category system_controller Aug 30 23:21:34 volumio volumio[4261]: info: Scanning category user_interface Aug 30 23:21:34 volumio volumio[4261]: info: Scanning into folder /data/plugins/ Aug 30 23:21:34 volumio volumio[4261]: info: Scanning category audio_interface Aug 30 23:21:34 volumio volumio[4261]: info: Plugin folders cleanup completed Aug 30 23:21:34 volumio volumio[4261]: info: ------------------------------------------- Aug 30 23:21:34 volumio volumio[4261]: info: ----- Core plugins startup ---- Aug 30 23:21:34 volumio volumio[4261]: info: ------------------------------------------- Aug 30 23:21:34 volumio volumio[4261]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 23:21:34 volumio volumio[4261]: info: Adding plugin upnp to MyMusic Plugins Aug 30 23:21:34 volumio volumio[4261]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 23:21:34 volumio volumio[4261]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 23:21:34 volumio volumio[4261]: info: Loading plugins from folder /data/plugins/ Aug 30 23:21:34 volumio volumio[4261]: info: Loading plugin "system"... Aug 30 23:21:34 volumio volumio[4261]: info: Loading plugin "appearance"... Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "network"... Aug 30 23:21:35 volumio volumio[4261]: info: Refreshing Cached IP Addresses Aug 30 23:21:35 volumio sudo[4287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 23:21:35 volumio sudo[4287]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:35 volumio sudo[4287]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:35 volumio sudo[4289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 23:21:35 volumio sudo[4289]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:35 volumio sudo[4289]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "services"... Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "alsa_controller"... Aug 30 23:21:35 volumio sudo[4302]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 23:21:35 volumio sudo[4302]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:35 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "wizard"... Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "networkfs"... Aug 30 23:21:35 volumio volumio[4261]: info: Starting Udev Watcher for removable devices Aug 30 23:21:35 volumio volumio[4261]: info: Ignoring mount for partition: boot Aug 30 23:21:35 volumio volumio[4261]: info: Ignoring mount for partition: volumio Aug 30 23:21:35 volumio volumio[4261]: info: Ignoring mount for partition: volumio_data Aug 30 23:21:35 volumio volumio[4261]: info: Mounting Device USB_1 Aug 30 23:21:35 volumio sudo[4318]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:35 volumio sudo[4318]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:35 volumio sudo[4318]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:35 volumio volumio[4261]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:35 volumio volumio[4261]: error: Failed to mount USB_1: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/USB_1" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:35 volumio volumio[4261]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:35 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "volumio_command_line_client"... Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "upnp"... Aug 30 23:21:35 volumio volumio[4261]: info: [1756576295406] Starting Upmpd Daemon Aug 30 23:21:35 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "my_music"... Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "mpd"... Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "upnp_browser"... Aug 30 23:21:35 volumio volumio[4261]: info: Loading plugin "alarm-clock"... Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "airplay_emulation"... Aug 30 23:21:36 volumio volumio[4261]: info: Starting Shairport Sync Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "last_100"... Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "webradio"... Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "i2s_dacs"... Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "volumiodiscovery"... Aug 30 23:21:36 volumio volumio[4261]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:36 volumio volumio[4261]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:36 volumio volumio[4261]: *** WARNING *** For more information see Aug 30 23:21:36 volumio node[4261]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:36 volumio volumio[4261]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:36 volumio volumio[4261]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:36 volumio volumio[4261]: *** WARNING *** For more information see Aug 30 23:21:36 volumio node[4261]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:36 volumio node[4261]: *** WARNING *** For more information see Aug 30 23:21:36 volumio node[4261]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:36 volumio node[4261]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:36 volumio node[4261]: *** WARNING *** For more information see Aug 30 23:21:36 volumio volumio[4261]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 23:21:36 volumio volumio[4261]: info: Discovery: Started advertising with name: Volumio Aug 30 23:21:36 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "outputs"... Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "albumart"... Aug 30 23:21:36 volumio volumio[4261]: info: Plugin example_plugin is not enabled Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "inputs"... Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "updater_comm"... Aug 30 23:21:36 volumio volumio[4261]: info: Plugin mpdemulation is not enabled Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "rest_api"... Aug 30 23:21:36 volumio volumio-remote-updater[581]: [2025-08-30 23:21:36] [connect] Successful connection Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "websocket"... Aug 30 23:21:36 volumio volumio[4261]: info: Starting Socket.io Server version 2.3.0 Aug 30 23:21:36 volumio volumio[4261]: info: Loading plugin "fusiondsp"... Aug 30 23:21:36 volumio volumio[4261]: Forking 3 albumart workers Aug 30 23:21:37 volumio volumio[4261]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 23:21:37 volumio volumio[4261]: info: Loading i18n strings for locale en Aug 30 23:21:37 volumio volumio[4261]: Updating browse sources language Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::initPlayerControls Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: Express server listening on port 3000 Aug 30 23:21:37 volumio volumio[4261]: [Metrics] WebUI: 4s 583.00ms Aug 30 23:21:37 volumio volumio[4261]: info: CoreStateMachine::resetVolumioState Aug 30 23:21:37 volumio volumio[4261]: info: CoreStateMachine::getcurrentVolume Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:37 volumio volumio[4261]: info: Cannot read play queue from file Aug 30 23:21:37 volumio volumio[4261]: info: Volumio Network Manager: Network status updated: 2 Aug 30 23:21:37 volumio volumio[4261]: Starting albumart workers Aug 30 23:21:37 volumio volumio[4261]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Aug 30 23:21:37 volumio volumio[4261]: Starting albumart workers Aug 30 23:21:37 volumio volumio-remote-updater[581]: [2025-08-30 23:21:37] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756576296 101 Aug 30 23:21:37 volumio volumio[4261]: 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 Aug 30 23:21:37 volumio volumio[4261]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Aug 30 23:21:37 volumio volumio[4261]: Starting albumart workers Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:37 volumio volumio[4261]: info: Executing start script for DAC IQaudIO DAC Plus Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:37 volumio volumio[4261]: info: Discovery: Getting this device information Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:37 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:37 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:38 volumio volumio[4261]: info: CoreStateMachine::setRepeat null single undefined Aug 30 23:21:38 volumio volumio[4261]: info: CoreStateMachine::pushState Aug 30 23:21:38 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:38 volumio volumio[4261]: info: CoreStateMachine::setRandom null Aug 30 23:21:38 volumio volumio[4261]: info: CoreStateMachine::pushState Aug 30 23:21:38 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:38 volumio volumio[4261]: info: Setting Device type: Raspberry PI Aug 30 23:21:38 volumio volumio[4261]: info: DAC script executed Aug 30 23:21:38 volumio volumio[4261]: info: Completed loading Core Plugins Aug 30 23:21:38 volumio volumio[4261]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:38 volumio volumio[4261]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:38 volumio volumio[4261]: info: CoreStateMachine::pushState Aug 30 23:21:38 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:38 volumio volumio[4261]: info: CoreStateMachine::updateTrackBlock Aug 30 23:21:38 volumio volumio[4261]: info: CorePlayQueue::getTrackBlock Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:38 volumio volumio[4261]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:38 volumio volumio[4261]: info: Reading ALSA contributions from plugins. Aug 30 23:21:38 volumio volumio[4261]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Aug 30 23:21:38 volumio volumio[4261]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:38 volumio volumio[4261]: info: Output device has changed, restarting MPD Aug 30 23:21:38 volumio sudo[4371]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:38 volumio sudo[4371]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:38 volumio sudo[4371]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:38 volumio volumio[4261]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:38 volumio sudo[4378]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:38 volumio sudo[4378]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:38 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 23:21:38 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:38 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:38 volumio volumio[4261]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:38 volumio volumio[4261]: info: ___________ START PLUGINS ___________ Aug 30 23:21:38 volumio volumio[4261]: info: ControllerMpd::onStart: Initializing MPD Aug 30 23:21:38 volumio volumio[4261]: info: Creating MPD Configuration file Aug 30 23:21:38 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:38 volumio sudo[4393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:38 volumio sudo[4393]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:38 volumio sudo[4393]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:38 volumio volumio[4261]: info: [1756576298624] CoreMusicLibrary::Adding element Media Servers Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:38 volumio sudo[4396]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:38 volumio sudo[4396]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:38 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 23:21:38 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:38 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:38 volumio volumio[4261]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:38 volumio volumio[4261]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:38 volumio volumio[4261]: info: [1756576298780] CoreMusicLibrary::Adding element Last_100 Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:38 volumio volumio[4261]: info: [1756576298783] CoreMusicLibrary::Adding element Webradio Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:38 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:38 volumio volumio[4261]: info: Initializing BBC Radios Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:38 volumio volumio[4261]: info: Loading i18n strings for locale en Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 23:21:38 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:38 volumio volumio[4261]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 23:21:38 volumio sudo[4302]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:38 volumio volumio[4261]: info: Volumio Calling Home Aug 30 23:21:38 volumio sudo[4407]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:38 volumio sudo[4407]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:38 volumio sudo[4407]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:38 volumio volumio[4261]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:39 volumio volumio[4261]: info: Discovery: adding a86aa518-ea14-4ca7-8ab5-e77925c9a66a Aug 30 23:21:39 volumio volumio[4261]: info: Discovery: Found device Volumio Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:39 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:39 volumio volumio[4261]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:39 volumio volumio[4261]: info: Reading ALSA contributions from plugins. Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:39 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 23:21:39 volumio volumio[4261]: info: MPD Permissions set Aug 30 23:21:39 volumio volumio[4261]: info: MPD Permissions set Aug 30 23:21:39 volumio volumio[4261]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:39 volumio volumio[4261]: info: CoreStateMachine::pushState Aug 30 23:21:39 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:39 volumio volumio[4261]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: Volumio called home Aug 30 23:21:39 volumio volumio[4261]: info: Starting Shairport Sync Aug 30 23:21:39 volumio volumio[4261]: info: Starting Shairport Sync Aug 30 23:21:39 volumio volumio[4261]: info: Starting Shairport Sync Aug 30 23:21:39 volumio sudo[4437]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:39 volumio sudo[4437]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:39 volumio sudo[4439]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:39 volumio sudo[4439]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:39 volumio volumio[4261]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:39 volumio sudo[4442]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:39 volumio sudo[4442]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:39 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:39 volumio volumio[4261]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:39 volumio volumio[4261]: info: Output device has changed, restarting MPD Aug 30 23:21:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:39 volumio sudo[4439]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:39 volumio sudo[4437]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:39 volumio sudo[4447]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:39 volumio sudo[4447]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:39 volumio volumio[4261]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:39 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:39 volumio sudo[4447]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:39 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:39 volumio sudo[4442]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:39 volumio volumio[4261]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:39 volumio sudo[4449]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:39 volumio sudo[4449]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:39 volumio volumio[4261]: info: MPD Permissions set Aug 30 23:21:39 volumio volumio[4261]: info: Shairport-Sync Started Aug 30 23:21:39 volumio volumio[4261]: Error adding Membership: Error: addMembership EINVAL Aug 30 23:21:39 volumio volumio[4261]: info: Shairport-Sync Started Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:39 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:39 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:39 volumio volumio[4261]: info: Starting Shairport Sync Aug 30 23:21:39 volumio sudo[4464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:39 volumio sudo[4464]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:39 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:39 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:39 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:39 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:39 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:39 volumio sudo[4464]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:39 volumio volumio[4261]: info: Shairport-Sync Started Aug 30 23:21:39 volumio sudo[4459]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:39 volumio sudo[4459]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:39 volumio sudo[4459]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:40 volumio volumio[4261]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:40 volumio volumio[4261]: 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 Aug 30 23:21:40 volumio volumio[4261]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:40 volumio volumio[4261]: info: camilladsp service started and running in background, instance 1 Aug 30 23:21:40 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:40 volumio volumio[4261]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:40 volumio volumio[4261]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 23:21:40 volumio volumio[4261]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:40 volumio volumio[4261]: info: FusionDsp loaded Aug 30 23:21:40 volumio volumio[4261]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:40 volumio sudo[4482]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 23:21:40 volumio sudo[4482]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:40 volumio volumio[4261]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 23:21:40 volumio volumio[4261]: info: Adding Signal Path Element [object Object] Aug 30 23:21:40 volumio volumio[4261]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 23:21:40 volumio sudo[4482]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:40 volumio volumio[4261]: info: FusionDsp - ---- installed callbackRead Aug 30 23:21:41 volumio volumio[4261]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:41 volumio volumio[4261]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 23:21:41 volumio volumio[4261]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 23:21:41 volumio volumio[4261]: at onErrorNT (internal/child_process.js:465:16) Aug 30 23:21:41 volumio volumio[4261]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 23:21:41 volumio volumio[4261]: errno: -2, Aug 30 23:21:41 volumio volumio[4261]: code: 'ENOENT', Aug 30 23:21:41 volumio volumio[4261]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:41 volumio volumio[4261]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:41 volumio volumio[4261]: spawnargs: [ Aug 30 23:21:41 volumio volumio[4261]: '-p', Aug 30 23:21:41 volumio volumio[4261]: 9876, Aug 30 23:21:41 volumio volumio[4261]: '-o', Aug 30 23:21:41 volumio volumio[4261]: '/tmp/camilladsp.log', Aug 30 23:21:41 volumio volumio[4261]: '-l', Aug 30 23:21:41 volumio volumio[4261]: 'warn', Aug 30 23:21:41 volumio volumio[4261]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 23:21:41 volumio volumio[4261]: ] Aug 30 23:21:41 volumio volumio[4261]: } Aug 30 23:21:41 volumio volumio[4261]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:41 volumio mpd[4471]: Aug 30 23:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 23:21:41 volumio systemd[1]: Started Music Player Daemon. Aug 30 23:21:41 volumio sudo[4449]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:41 volumio sudo[4396]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:41 volumio sudo[4378]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:41 volumio sudo[4498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 23:20 Aug 30 23:21:41 volumio sudo[4498]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:41 volumio sudo[4498]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:41 volumio volumio-remote-updater[581]: [2025-08-30 23:21:41] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 30 23:21:41 volumio volumio-remote-updater[581]: [2025-08-30 23:21:41] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 30 23:21:41 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 30 23:21:41 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 30 23:21:41 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:41 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:42 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 30 23:21:42 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 14. Aug 30 23:21:42 volumio systemd[1]: Stopped Volumio Backend Module. Aug 30 23:21:42 volumio systemd[1]: Started Volumio Backend Module. Aug 30 23:21:42 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:42 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:43 volumio volumio[4508]: info: ------------------------------------------- Aug 30 23:21:43 volumio volumio[4508]: info: ----- Volumio3 ---- Aug 30 23:21:43 volumio volumio[4508]: info: ------------------------------------------- Aug 30 23:21:43 volumio volumio[4508]: info: ----- System startup ---- Aug 30 23:21:43 volumio volumio[4508]: info: ------------------------------------------- Aug 30 23:21:44 volumio volumio[4508]: info: MYVOLUMIO Environment detected Aug 30 23:21:44 volumio volumio[4508]: info: Plugin folders cleanup Aug 30 23:21:44 volumio volumio[4508]: info: Scanning into folder /volumio/app/plugins/ Aug 30 23:21:44 volumio volumio[4508]: info: Scanning category audio_interface Aug 30 23:21:44 volumio volumio[4508]: info: Scanning category miscellanea Aug 30 23:21:44 volumio volumio[4508]: info: Scanning category music_service Aug 30 23:21:44 volumio volumio[4508]: info: Scanning category plugins.json Aug 30 23:21:44 volumio volumio[4508]: info: Scanning category system_controller Aug 30 23:21:44 volumio volumio[4508]: info: Scanning category user_interface Aug 30 23:21:44 volumio volumio[4508]: info: Scanning into folder /data/plugins/ Aug 30 23:21:44 volumio volumio[4508]: info: Scanning category audio_interface Aug 30 23:21:44 volumio volumio[4508]: info: Plugin folders cleanup completed Aug 30 23:21:44 volumio volumio[4508]: info: ------------------------------------------- Aug 30 23:21:44 volumio volumio[4508]: info: ----- Core plugins startup ---- Aug 30 23:21:44 volumio volumio[4508]: info: ------------------------------------------- Aug 30 23:21:44 volumio volumio[4508]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 23:21:44 volumio volumio[4508]: info: Adding plugin upnp to MyMusic Plugins Aug 30 23:21:44 volumio volumio[4508]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 23:21:44 volumio volumio[4508]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 23:21:44 volumio volumio[4508]: info: Loading plugins from folder /data/plugins/ Aug 30 23:21:44 volumio volumio[4508]: info: Loading plugin "system"... Aug 30 23:21:44 volumio volumio[4508]: info: Loading plugin "appearance"... Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "network"... Aug 30 23:21:45 volumio volumio[4508]: info: Refreshing Cached IP Addresses Aug 30 23:21:45 volumio sudo[4535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 23:21:45 volumio sudo[4535]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:45 volumio sudo[4535]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:45 volumio sudo[4537]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 23:21:45 volumio sudo[4537]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:45 volumio sudo[4537]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "services"... Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "alsa_controller"... Aug 30 23:21:45 volumio sudo[4550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 23:21:45 volumio sudo[4550]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:45 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "wizard"... Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "networkfs"... Aug 30 23:21:45 volumio volumio[4508]: info: Starting Udev Watcher for removable devices Aug 30 23:21:45 volumio volumio[4508]: info: Ignoring mount for partition: boot Aug 30 23:21:45 volumio volumio[4508]: info: Ignoring mount for partition: volumio Aug 30 23:21:45 volumio volumio[4508]: info: Ignoring mount for partition: volumio_data Aug 30 23:21:45 volumio volumio[4508]: info: Mounting Device USB_1 Aug 30 23:21:45 volumio sudo[4566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:45 volumio sudo[4566]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:45 volumio sudo[4566]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:45 volumio volumio[4508]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:45 volumio volumio[4508]: error: Failed to mount USB_1: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/USB_1" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:45 volumio volumio[4508]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:45 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "volumio_command_line_client"... Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "upnp"... Aug 30 23:21:45 volumio volumio[4508]: info: [1756576305615] Starting Upmpd Daemon Aug 30 23:21:45 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "my_music"... Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "mpd"... Aug 30 23:21:45 volumio volumio[4508]: info: Loading plugin "upnp_browser"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "alarm-clock"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "airplay_emulation"... Aug 30 23:21:46 volumio volumio[4508]: info: Starting Shairport Sync Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "last_100"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "webradio"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "i2s_dacs"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "volumiodiscovery"... Aug 30 23:21:46 volumio volumio[4508]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:46 volumio volumio[4508]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:46 volumio volumio[4508]: *** WARNING *** For more information see Aug 30 23:21:46 volumio volumio[4508]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:46 volumio node[4508]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:46 volumio volumio[4508]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:46 volumio volumio[4508]: *** WARNING *** For more information see Aug 30 23:21:46 volumio node[4508]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:46 volumio node[4508]: *** WARNING *** For more information see Aug 30 23:21:46 volumio node[4508]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:46 volumio node[4508]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:46 volumio node[4508]: *** WARNING *** For more information see Aug 30 23:21:46 volumio volumio[4508]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 23:21:46 volumio volumio[4508]: info: Discovery: Started advertising with name: Volumio Aug 30 23:21:46 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "outputs"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "albumart"... Aug 30 23:21:46 volumio volumio[4508]: info: Plugin example_plugin is not enabled Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "inputs"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "updater_comm"... Aug 30 23:21:46 volumio volumio[4508]: info: Plugin mpdemulation is not enabled Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "rest_api"... Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "websocket"... Aug 30 23:21:46 volumio volumio[4508]: info: Starting Socket.io Server version 2.3.0 Aug 30 23:21:46 volumio volumio[4508]: info: Loading plugin "fusiondsp"... Aug 30 23:21:46 volumio volumio-remote-updater[581]: [2025-08-30 23:21:46] [connect] Successful connection Aug 30 23:21:46 volumio volumio[4508]: Forking 3 albumart workers Aug 30 23:21:47 volumio volumio[4508]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 23:21:47 volumio volumio[4508]: info: Loading i18n strings for locale en Aug 30 23:21:47 volumio volumio[4508]: Updating browse sources language Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::initPlayerControls Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:47 volumio volumio[4508]: Express server listening on port 3000 Aug 30 23:21:47 volumio volumio[4508]: [Metrics] WebUI: 4s 557.24ms Aug 30 23:21:47 volumio volumio[4508]: info: CoreStateMachine::resetVolumioState Aug 30 23:21:47 volumio volumio[4508]: info: CoreStateMachine::getcurrentVolume Aug 30 23:21:47 volumio volumio[4508]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:47 volumio volumio[4508]: info: Cannot read play queue from file Aug 30 23:21:47 volumio volumio[4508]: info: Volumio Network Manager: Network status updated: 2 Aug 30 23:21:47 volumio volumio[4508]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Aug 30 23:21:47 volumio volumio-remote-updater[581]: [2025-08-30 23:21:47] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756576306 101 Aug 30 23:21:47 volumio volumio[4508]: 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 Aug 30 23:21:47 volumio volumio[4508]: Starting albumart workers Aug 30 23:21:47 volumio volumio[4508]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Aug 30 23:21:48 volumio volumio[4508]: Starting albumart workers Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:48 volumio volumio[4508]: info: Discovery: Getting this device information Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:48 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:48 volumio volumio[4508]: Starting albumart workers Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:48 volumio volumio[4508]: info: Executing start script for DAC IQaudIO DAC Plus Aug 30 23:21:48 volumio volumio[4508]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:48 volumio volumio[4508]: info: CoreStateMachine::pushState Aug 30 23:21:48 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:48 volumio volumio[4508]: info: CoreStateMachine::updateTrackBlock Aug 30 23:21:48 volumio volumio[4508]: info: CorePlayQueue::getTrackBlock Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:48 volumio volumio[4508]: info: CoreStateMachine::setRepeat null single undefined Aug 30 23:21:48 volumio volumio[4508]: info: CoreStateMachine::pushState Aug 30 23:21:48 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:48 volumio volumio[4508]: info: CoreStateMachine::setRandom null Aug 30 23:21:48 volumio volumio[4508]: info: CoreStateMachine::pushState Aug 30 23:21:48 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:48 volumio volumio[4508]: info: Setting Device type: Raspberry PI Aug 30 23:21:48 volumio volumio[4508]: info: DAC script executed Aug 30 23:21:48 volumio volumio[4508]: info: Completed loading Core Plugins Aug 30 23:21:48 volumio volumio[4508]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:48 volumio volumio[4508]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:48 volumio volumio[4508]: info: Reading ALSA contributions from plugins. Aug 30 23:21:48 volumio volumio[4508]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Aug 30 23:21:48 volumio volumio[4508]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:48 volumio volumio[4508]: info: Output device has changed, restarting MPD Aug 30 23:21:48 volumio volumio[4508]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:48 volumio sudo[4615]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:48 volumio sudo[4615]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:48 volumio sudo[4617]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:48 volumio sudo[4617]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:48 volumio sudo[4615]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:48 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 23:21:48 volumio volumio[4508]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:48 volumio volumio[4508]: info: ___________ START PLUGINS ___________ Aug 30 23:21:48 volumio volumio[4508]: info: ControllerMpd::onStart: Initializing MPD Aug 30 23:21:48 volumio volumio[4508]: info: Creating MPD Configuration file Aug 30 23:21:48 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:48 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:48 volumio volumio[4508]: info: [1756576308624] CoreMusicLibrary::Adding element Media Servers Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:48 volumio sudo[4624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:48 volumio sudo[4624]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:48 volumio sudo[4626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:48 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:48 volumio sudo[4624]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:48 volumio sudo[4626]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:48 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 23:21:48 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:48 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:48 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:48 volumio volumio[4508]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:48 volumio sudo[4630]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:48 volumio sudo[4630]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:48 volumio sudo[4630]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:48 volumio volumio[4508]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:48 volumio volumio[4508]: info: [1756576308883] CoreMusicLibrary::Adding element Last_100 Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:48 volumio volumio[4508]: info: [1756576308900] CoreMusicLibrary::Adding element Webradio Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:48 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:48 volumio volumio[4508]: info: Initializing BBC Radios Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: Loading i18n strings for locale en Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 23:21:49 volumio volumio[4508]: info: Volumio Calling Home Aug 30 23:21:49 volumio sudo[4550]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:49 volumio volumio[4508]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:49 volumio volumio[4508]: info: Discovery: adding a86aa518-ea14-4ca7-8ab5-e77925c9a66a Aug 30 23:21:49 volumio volumio[4508]: info: Discovery: Found device Volumio Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:49 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:49 volumio volumio[4508]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:49 volumio volumio[4508]: info: Reading ALSA contributions from plugins. Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:49 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 23:21:49 volumio volumio[4508]: info: MPD Permissions set Aug 30 23:21:49 volumio volumio[4508]: info: MPD Permissions set Aug 30 23:21:49 volumio volumio[4508]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:49 volumio volumio[4508]: info: CoreStateMachine::pushState Aug 30 23:21:49 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:49 volumio volumio[4508]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: Volumio called home Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:49 volumio volumio[4508]: info: Discovery: Getting this device information Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:49 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:49 volumio volumio[4508]: info: Starting Shairport Sync Aug 30 23:21:49 volumio volumio[4508]: info: Starting Shairport Sync Aug 30 23:21:49 volumio volumio[4508]: info: Starting Shairport Sync Aug 30 23:21:49 volumio sudo[4685]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:49 volumio sudo[4685]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:49 volumio sudo[4687]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:49 volumio sudo[4687]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:49 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:49 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:49 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:49 volumio volumio[4508]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:49 volumio sudo[4690]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:49 volumio sudo[4690]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:49 volumio volumio[4508]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:49 volumio volumio[4508]: info: Output device has changed, restarting MPD Aug 30 23:21:49 volumio volumio[4508]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:49 volumio sudo[4695]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:49 volumio sudo[4695]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:49 volumio sudo[4695]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:49 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:49 volumio sudo[4697]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:49 volumio sudo[4685]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:49 volumio sudo[4697]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:49 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:49 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:49 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:49 volumio sudo[4687]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:49 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:49 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:49 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:49 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:49 volumio volumio[4508]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:49 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:49 volumio sudo[4690]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:49 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 23:21:49 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:49 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:49 volumio volumio[4508]: info: MPD Permissions set Aug 30 23:21:49 volumio volumio[4508]: info: Shairport-Sync Started Aug 30 23:21:49 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:49 volumio volumio[4508]: Error adding Membership: Error: addMembership EINVAL Aug 30 23:21:49 volumio volumio[4508]: info: Shairport-Sync Started Aug 30 23:21:49 volumio volumio[4508]: info: Shairport-Sync Started Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:49 volumio volumio[4508]: info: Starting Shairport Sync Aug 30 23:21:50 volumio sudo[4713]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:21:50 volumio sudo[4713]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:50 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:21:50 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:21:50 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:50 volumio sudo[4705]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:50 volumio sudo[4705]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:50 volumio sudo[4705]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:50 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:21:50 volumio sudo[4713]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:50 volumio volumio[4508]: info: Shairport-Sync Started Aug 30 23:21:51 volumio volumio[4508]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:51 volumio volumio[4508]: 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 Aug 30 23:21:51 volumio volumio[4508]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Aug 30 23:21:51 volumio volumio[4508]: info: camilladsp service started and running in background, instance 1 Aug 30 23:21:51 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:51 volumio volumio[4508]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:51 volumio volumio[4508]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 23:21:51 volumio volumio[4508]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 23:21:51 volumio volumio[4508]: info: FusionDsp loaded Aug 30 23:21:51 volumio volumio[4508]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:51 volumio sudo[4731]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 23:21:51 volumio sudo[4731]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:51 volumio volumio[4508]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 23:21:51 volumio volumio[4508]: info: Adding Signal Path Element [object Object] Aug 30 23:21:51 volumio volumio[4508]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 23:21:51 volumio volumio[4508]: info: FusionDsp - ---- installed callbackRead Aug 30 23:21:51 volumio volumio[4508]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:51 volumio sudo[4731]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:51 volumio volumio[4508]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 23:21:51 volumio volumio[4508]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 23:21:51 volumio volumio[4508]: at onErrorNT (internal/child_process.js:465:16) Aug 30 23:21:51 volumio volumio[4508]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 23:21:51 volumio volumio[4508]: errno: -2, Aug 30 23:21:51 volumio volumio[4508]: code: 'ENOENT', Aug 30 23:21:51 volumio volumio[4508]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:51 volumio volumio[4508]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 23:21:51 volumio volumio[4508]: spawnargs: [ Aug 30 23:21:51 volumio volumio[4508]: '-p', Aug 30 23:21:51 volumio volumio[4508]: 9876, Aug 30 23:21:51 volumio volumio[4508]: '-o', Aug 30 23:21:51 volumio volumio[4508]: '/tmp/camilladsp.log', Aug 30 23:21:51 volumio volumio[4508]: '-l', Aug 30 23:21:51 volumio volumio[4508]: 'warn', Aug 30 23:21:51 volumio volumio[4508]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 23:21:51 volumio volumio[4508]: ] Aug 30 23:21:51 volumio volumio[4508]: } Aug 30 23:21:51 volumio volumio[4508]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:21:51 volumio mpd[4718]: Aug 30 23:21 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 23:21:51 volumio systemd[1]: Started Music Player Daemon. Aug 30 23:21:51 volumio sudo[4697]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:51 volumio sudo[4626]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:51 volumio sudo[4617]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:51 volumio sudo[4744]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 23:20 Aug 30 23:21:51 volumio sudo[4744]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:52 volumio sudo[4744]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:52 volumio volumio-remote-updater[581]: [2025-08-30 23:21:52] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Aug 30 23:21:52 volumio volumio-remote-updater[581]: [2025-08-30 23:21:52] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Aug 30 23:21:52 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Aug 30 23:21:52 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Aug 30 23:21:52 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:52 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:52 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Aug 30 23:21:52 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 15. Aug 30 23:21:52 volumio systemd[1]: Stopped Volumio Backend Module. Aug 30 23:21:52 volumio systemd[1]: Started Volumio Backend Module. Aug 30 23:21:52 volumio systemd[1]: Started dynamicswap service. Aug 30 23:21:52 volumio systemd[1]: dynamicswap.service: Succeeded. Aug 30 23:21:53 volumio volumio[4754]: info: ------------------------------------------- Aug 30 23:21:53 volumio volumio[4754]: info: ----- Volumio3 ---- Aug 30 23:21:53 volumio volumio[4754]: info: ------------------------------------------- Aug 30 23:21:53 volumio volumio[4754]: info: ----- System startup ---- Aug 30 23:21:53 volumio volumio[4754]: info: ------------------------------------------- Aug 30 23:21:54 volumio volumio[4754]: info: MYVOLUMIO Environment detected Aug 30 23:21:54 volumio volumio[4754]: info: Plugin folders cleanup Aug 30 23:21:54 volumio volumio[4754]: info: Scanning into folder /volumio/app/plugins/ Aug 30 23:21:54 volumio volumio[4754]: info: Scanning category audio_interface Aug 30 23:21:54 volumio volumio[4754]: info: Scanning category miscellanea Aug 30 23:21:54 volumio volumio[4754]: info: Scanning category music_service Aug 30 23:21:54 volumio volumio[4754]: info: Scanning category plugins.json Aug 30 23:21:54 volumio volumio[4754]: info: Scanning category system_controller Aug 30 23:21:54 volumio volumio[4754]: info: Scanning category user_interface Aug 30 23:21:54 volumio volumio[4754]: info: Scanning into folder /data/plugins/ Aug 30 23:21:54 volumio volumio[4754]: info: Scanning category audio_interface Aug 30 23:21:54 volumio volumio[4754]: info: Plugin folders cleanup completed Aug 30 23:21:54 volumio volumio[4754]: info: ------------------------------------------- Aug 30 23:21:54 volumio volumio[4754]: info: ----- Core plugins startup ---- Aug 30 23:21:54 volumio volumio[4754]: info: ------------------------------------------- Aug 30 23:21:54 volumio volumio[4754]: info: Loading plugins from folder /volumio/app/plugins/ Aug 30 23:21:54 volumio volumio[4754]: info: Adding plugin upnp to MyMusic Plugins Aug 30 23:21:54 volumio volumio[4754]: info: Adding plugin airplay_emulation to MyMusic Plugins Aug 30 23:21:54 volumio volumio[4754]: info: Adding plugin upnp_browser to MyMusic Plugins Aug 30 23:21:54 volumio volumio[4754]: info: Loading plugins from folder /data/plugins/ Aug 30 23:21:54 volumio volumio[4754]: info: Loading plugin "system"... Aug 30 23:21:54 volumio volumio[4754]: info: Loading plugin "appearance"... Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "network"... Aug 30 23:21:55 volumio volumio[4754]: info: Refreshing Cached IP Addresses Aug 30 23:21:55 volumio sudo[4782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 23:21:55 volumio sudo[4782]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:55 volumio sudo[4782]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:55 volumio sudo[4784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 23:21:55 volumio sudo[4784]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:55 volumio sudo[4784]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "services"... Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "alsa_controller"... Aug 30 23:21:55 volumio sudo[4793]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Aug 30 23:21:55 volumio sudo[4793]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:55 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "wizard"... Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "networkfs"... Aug 30 23:21:55 volumio volumio[4754]: info: Starting Udev Watcher for removable devices Aug 30 23:21:55 volumio volumio[4754]: info: Ignoring mount for partition: boot Aug 30 23:21:55 volumio volumio[4754]: info: Ignoring mount for partition: volumio Aug 30 23:21:55 volumio volumio[4754]: info: Ignoring mount for partition: volumio_data Aug 30 23:21:55 volumio volumio[4754]: info: Mounting Device USB_1 Aug 30 23:21:55 volumio sudo[4813]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/USB_1 -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:55 volumio sudo[4813]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:55 volumio sudo[4813]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:55 volumio volumio[4754]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:55 volumio volumio[4754]: error: Failed to mount USB_1: Error: Command failed: /usr/bin/sudo /bin/mount "/dev/sda1" "/mnt/USB/USB_1" -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Aug 30 23:21:55 volumio volumio[4754]: mount: /media/USB_1: /dev/sda1 already mounted on /media/USB_1. Aug 30 23:21:55 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "volumio_command_line_client"... Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "upnp"... Aug 30 23:21:55 volumio volumio[4754]: info: [1756576315913] Starting Upmpd Daemon Aug 30 23:21:55 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "my_music"... Aug 30 23:21:55 volumio volumio[4754]: info: Loading plugin "mpd"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "upnp_browser"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "alarm-clock"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "airplay_emulation"... Aug 30 23:21:56 volumio volumio[4754]: info: Starting Shairport Sync Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "last_100"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "webradio"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "i2s_dacs"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "volumiodiscovery"... Aug 30 23:21:56 volumio volumio[4754]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:56 volumio volumio[4754]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:56 volumio volumio[4754]: *** WARNING *** For more information see Aug 30 23:21:56 volumio node[4754]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:56 volumio volumio[4754]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:56 volumio volumio[4754]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:56 volumio volumio[4754]: *** WARNING *** For more information see Aug 30 23:21:56 volumio node[4754]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:56 volumio node[4754]: *** WARNING *** For more information see Aug 30 23:21:56 volumio node[4754]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Aug 30 23:21:56 volumio node[4754]: *** WARNING *** Please fix your application to use the native API of Avahi! Aug 30 23:21:56 volumio node[4754]: *** WARNING *** For more information see Aug 30 23:21:56 volumio volumio[4754]: info: Applying required configuration parameters for plugin volumiodiscovery Aug 30 23:21:56 volumio volumio[4754]: info: Discovery: Started advertising with name: Volumio Aug 30 23:21:56 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "outputs"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "albumart"... Aug 30 23:21:56 volumio volumio[4754]: info: Plugin example_plugin is not enabled Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "inputs"... Aug 30 23:21:56 volumio volumio[4754]: info: Loading plugin "updater_comm"... Aug 30 23:21:57 volumio volumio-remote-updater[581]: [2025-08-30 23:21:57] [connect] Successful connection Aug 30 23:21:57 volumio volumio[4754]: info: Plugin mpdemulation is not enabled Aug 30 23:21:57 volumio volumio[4754]: info: Loading plugin "rest_api"... Aug 30 23:21:57 volumio volumio[4754]: info: Loading plugin "websocket"... Aug 30 23:21:57 volumio volumio[4754]: info: Starting Socket.io Server version 2.3.0 Aug 30 23:21:57 volumio volumio[4754]: info: Loading plugin "fusiondsp"... Aug 30 23:21:57 volumio volumio[4754]: Forking 3 albumart workers Aug 30 23:21:57 volumio volumio[4754]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 23:21:57 volumio volumio[4754]: info: Loading i18n strings for locale en Aug 30 23:21:57 volumio volumio[4754]: Updating browse sources language Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::initPlayerControls Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:57 volumio volumio[4754]: Express server listening on port 3000 Aug 30 23:21:57 volumio volumio[4754]: [Metrics] WebUI: 4s 517.62ms Aug 30 23:21:57 volumio volumio[4754]: info: CoreStateMachine::resetVolumioState Aug 30 23:21:57 volumio volumio[4754]: info: CoreStateMachine::getcurrentVolume Aug 30 23:21:57 volumio volumio[4754]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:58 volumio volumio[4754]: info: Cannot read play queue from file Aug 30 23:21:58 volumio volumio[4754]: info: Volumio Network Manager: Network status updated: 2 Aug 30 23:21:58 volumio volumio[4754]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Aug 30 23:21:58 volumio volumio-remote-updater[581]: [2025-08-30 23:21:58] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1756576317 101 Aug 30 23:21:58 volumio volumio[4754]: 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 Aug 30 23:21:58 volumio volumio[4754]: verbose: New Socket.io Connection to 192.168.29.167 from 192.168.29.201 UA: Mozilla/5.0 (Linux; Android 15; SM-S938B Build/AP3A.240905.015.A2; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/139.0.7258.144 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:58 volumio volumio[4754]: Starting albumart workers Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:58 volumio volumio[4754]: info: Discovery: Getting this device information Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:58 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:58 volumio volumio[4754]: Starting albumart workers Aug 30 23:21:58 volumio volumio[4754]: Starting albumart workers Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:58 volumio volumio[4754]: info: Executing start script for DAC IQaudIO DAC Plus Aug 30 23:21:58 volumio volumio[4754]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:58 volumio volumio[4754]: info: CoreStateMachine::pushState Aug 30 23:21:58 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:58 volumio volumio[4754]: info: CoreStateMachine::updateTrackBlock Aug 30 23:21:58 volumio volumio[4754]: info: CorePlayQueue::getTrackBlock Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::volumioRetrievevolume Aug 30 23:21:58 volumio volumio[4754]: info: Setting Device type: Raspberry PI Aug 30 23:21:58 volumio volumio[4754]: info: CoreStateMachine::setRepeat null single undefined Aug 30 23:21:58 volumio volumio[4754]: info: CoreStateMachine::pushState Aug 30 23:21:58 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:58 volumio volumio[4754]: info: CoreStateMachine::setRandom null Aug 30 23:21:58 volumio volumio[4754]: info: CoreStateMachine::pushState Aug 30 23:21:58 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:58 volumio volumio[4754]: info: DAC script executed Aug 30 23:21:58 volumio volumio[4754]: info: Completed loading Core Plugins Aug 30 23:21:58 volumio volumio[4754]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:58 volumio volumio[4754]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:58 volumio volumio[4754]: info: Reading ALSA contributions from plugins. Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 23:21:58 volumio volumio[4754]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:21:58 volumio volumio[4754]: info: Output device has changed, restarting MPD Aug 30 23:21:58 volumio sudo[4900]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:58 volumio sudo[4900]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:58 volumio volumio[4754]: info: Output device has changed, restarting Shairport Sync Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:58 volumio sudo[4900]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:58 volumio sudo[4903]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:58 volumio sudo[4903]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:58 volumio volumio[4754]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:58 volumio volumio[4754]: info: ___________ START PLUGINS ___________ Aug 30 23:21:58 volumio volumio[4754]: info: ControllerMpd::onStart: Initializing MPD Aug 30 23:21:58 volumio volumio[4754]: info: Creating MPD Configuration file Aug 30 23:21:58 volumio systemd[1]: Stopping Music Player Daemon... Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:58 volumio volumio[4754]: info: [1756576318931] CoreMusicLibrary::Adding element Media Servers Aug 30 23:21:58 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:58 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:58 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:58 volumio sudo[4911]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:21:58 volumio sudo[4909]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:59 volumio sudo[4911]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:59 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:59 volumio sudo[4909]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:59 volumio sudo[4909]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:59 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Aug 30 23:21:59 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:21:59 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:21:59 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:21:59 volumio volumio[4754]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:59 volumio volumio[4754]: info: [1756576319199] CoreMusicLibrary::Adding element Last_100 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Aug 30 23:21:59 volumio volumio[4754]: info: [1756576319207] CoreMusicLibrary::Adding element Webradio Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:59 volumio volumio[4754]: info: Initializing BBC Radios Aug 30 23:21:59 volumio sudo[4926]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:21:59 volumio sudo[4926]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:21:59 volumio sudo[4926]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: Loading i18n strings for locale en Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 23:21:59 volumio volumio[4754]: info: Volumio Calling Home Aug 30 23:21:59 volumio sudo[4793]: pam_unix(sudo:session): session closed for user root Aug 30 23:21:59 volumio volumio[4754]: info: Preparing to generate the ALSA configuration file Aug 30 23:21:59 volumio volumio[4754]: info: Discovery: adding a86aa518-ea14-4ca7-8ab5-e77925c9a66a Aug 30 23:21:59 volumio volumio[4754]: info: Discovery: Found device Volumio Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:59 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:59 volumio volumio[4754]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Aug 30 23:21:59 volumio volumio[4754]: info: Reading ALSA contributions from plugins. Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:59 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 23:21:59 volumio volumio[4754]: info: Received Get System Info Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 23:21:59 volumio volumio[4754]: info: Discovery: Getting this device information Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:59 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:59 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:59 volumio volumio[4754]: info: Listing playlists Aug 30 23:21:59 volumio volumio[4754]: info: MPD Permissions set Aug 30 23:21:59 volumio volumio[4754]: info: MPD Permissions set Aug 30 23:21:59 volumio volumio[4754]: info: VolumeController:: Volume=100 Mute =false Aug 30 23:21:59 volumio volumio[4754]: info: CoreStateMachine::pushState Aug 30 23:21:59 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioPushState Aug 30 23:21:59 volumio volumio[4754]: verbose: New Socket.io Connection to 192.168.29.167:3000 from 192.168.29.201 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Aug 30 23:21:59 volumio volumio[4754]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 5 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::volumioGetState Aug 30 23:21:59 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: wizard , getShowWizard Aug 30 23:21:59 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getShowWizard Aug 30 23:22:00 volumio volumio[4754]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:22:00 volumio volumio[4754]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:22:00 volumio volumio[4754]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:22:00 volumio volumio[4754]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 23:22:00 volumio volumio[4754]: info: Volumio called home Aug 30 23:22:00 volumio volumio[4754]: info: Starting Shairport Sync Aug 30 23:22:00 volumio volumio[4754]: info: Starting Shairport Sync Aug 30 23:22:00 volumio volumio[4754]: info: Starting Shairport Sync Aug 30 23:22:00 volumio sudo[4970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:22:00 volumio sudo[4970]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:22:00 volumio sudo[4972]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:22:00 volumio sudo[4972]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:22:00 volumio sudo[4975]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 23:22:00 volumio sudo[4975]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:22:00 volumio volumio[4754]: info: CoreCommandRouter::volumioGetState Aug 30 23:22:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:22:00 volumio volumio[4754]: info: CorePlayQueue::getTrack 0 Aug 30 23:22:00 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:22:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:22:00 volumio volumio[4754]: info: Asound.conf file unchanged, so no further update is needed Aug 30 23:22:00 volumio volumio[4754]: info: Output device has changed, restarting MPD Aug 30 23:22:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:22:00 volumio sudo[4972]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:00 volumio sudo[4970]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:00 volumio volumio[4754]: info: Output device has changed, restarting Shairport Sync Aug 30 23:22:00 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 23:22:00 volumio volumio[4754]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 23:22:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 23:22:00 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Aug 30 23:22:00 volumio systemd[1]: shairport-sync.service: Succeeded. Aug 30 23:22:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 23:22:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 23:22:00 volumio sudo[4981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 23:22:00 volumio sudo[4981]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:22:00 volumio sudo[4981]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:00 volumio sudo[4983]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 23:22:00 volumio sudo[4983]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:22:00 volumio volumio[4754]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 23:22:00 volumio sudo[4975]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:00 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 23:22:00 volumio systemd[1]: mpd.service: Succeeded. Aug 30 23:22:00 volumio systemd[1]: Stopped Music Player Daemon. Aug 30 23:22:00 volumio volumio[4754]: info: FusionDsp - Aug 30 23:22:00 volumio systemd[1]: Starting Music Player Daemon... Aug 30 23:22:00 volumio sudo[4989]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 23:22:00 volumio sudo[4989]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 23:22:00 volumio sudo[4989]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:00 volumio volumio[4754]: info: FusionDsp - Aug 30 23:22:00 volumio volumio[4754]: info: FusionDsp - Aug 30 23:22:01 volumio volumio[4754]: info: FusionDsp - Aug 30 23:22:01 volumio volumio[4754]: info: FusionDsp - undefined Aug 30 23:22:01 volumio volumio[4754]: info: FusionDsp - undefined Aug 30 23:22:01 volumio volumio[4754]: info: FusionDsp - undefined Aug 30 23:22:01 volumio volumio[4754]: info: FusionDsp - undefined Aug 30 23:22:01 volumio volumio[4754]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:22:01 volumio volumio[4754]: TypeError: Cannot read property 'off' of undefined Aug 30 23:22:01 volumio volumio[4754]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Aug 30 23:22:01 volumio volumio[4754]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Aug 30 23:22:01 volumio volumio[4754]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Aug 30 23:22:01 volumio volumio[4754]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Aug 30 23:22:01 volumio volumio[4754]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Aug 30 23:22:01 volumio volumio[4754]: at Socket.emit (events.js:315:20) Aug 30 23:22:01 volumio volumio[4754]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Aug 30 23:22:01 volumio volumio[4754]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Aug 30 23:22:01 volumio volumio[4754]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 23:22:02 volumio mpd[4993]: Aug 30 23:22 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 23:22:02 volumio systemd[1]: Started Music Player Daemon. Aug 30 23:22:02 volumio sudo[4911]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:02 volumio sudo[4903]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:02 volumio sudo[4983]: pam_unix(sudo:session): session closed for user root Aug 30 23:22:02 volumio sudo[5009]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-08-30 23:21 Aug 30 23:22:02 volumio sudo[5009]: 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="29866754e5f1d7e4d0f581c10d9f22852f6f21db" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="fc4c820ddd3b5fc1a7a6b54ef112273ebd122010" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Sat 26 Jul 2025 10:25:36 AM CEST" VOLUMIO_VERSION="3.832" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="cf6e14681b2ecbbdc9a62186b0f3114c"