-- Logs begin at Thu 2019-02-14 05:11:58 EST, end at Tue 2025-04-22 10:58:13 EDT. -- Apr 22 10:57:00 volumio volumio[879]: info: END DOWNLOAD: https://plugins.volumio.workers.dev/pluginsv2/downloadLatestStable/fusiondsp/volumio/buster/armhf Apr 22 10:57:01 volumio volumio[879]: info: Check plugin dependencies Apr 22 10:57:01 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 22 10:57:01 volumio volumio[879]: info: Rename folder Apr 22 10:57:01 volumio volumio[879]: info: Folder /tmp/downloaded_plugin.zip removed Apr 22 10:57:01 volumio volumio[879]: info: Move to category Apr 22 10:57:02 volumio volumio[879]: info: Checking if install.sh is present Apr 22 10:57:02 volumio volumio[879]: info: Executing install.sh Apr 22 10:57:02 volumio sudo[1852]: pam_unix(sudo:auth): authentication failure; logname= uid=1000 euid=0 tty= ruser=volumio rhost= user=volumio Apr 22 10:57:03 volumio sudo[1852]: pam_unix(sudo:auth): conversation failed Apr 22 10:57:03 volumio sudo[1852]: pam_unix(sudo:auth): auth could not identify password for [volumio] Apr 22 10:57:03 volumio sudo[1852]: volumio : 1 incorrect password attempt ; TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/install.sh Apr 22 10:57:03 volumio volumio[879]: info: Install script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/audio_interface/fusiondsp/install.sh > /tmp/installog Apr 22 10:57:03 volumio volumio[879]: [sudo] password for volumio: Sorry, try again. Apr 22 10:57:03 volumio volumio[879]: [sudo] password for volumio: Apr 22 10:57:03 volumio volumio[879]: sudo: no password was provided Apr 22 10:57:03 volumio volumio[879]: sudo: 1 incorrect password attempt Apr 22 10:57:03 volumio volumio[879]: info: An error occurred installing the plugin. Rolling back config Apr 22 10:57:03 volumio volumio[879]: info: Plugin folders cleanup Apr 22 10:57:03 volumio volumio[879]: info: Scanning into folder /volumio/app/plugins/ Apr 22 10:57:03 volumio volumio[879]: info: Scanning category audio_interface Apr 22 10:57:03 volumio volumio[879]: info: Scanning category miscellanea Apr 22 10:57:03 volumio volumio[879]: info: Scanning category music_service Apr 22 10:57:03 volumio volumio[879]: info: Scanning category plugins.json Apr 22 10:57:03 volumio volumio[879]: info: Scanning category system_controller Apr 22 10:57:03 volumio volumio[879]: info: Scanning category user_interface Apr 22 10:57:03 volumio volumio[879]: info: Scanning into folder /data/plugins/ Apr 22 10:57:03 volumio volumio[879]: info: Scanning category audio_interface Apr 22 10:57:03 volumio volumio[879]: info: Scanning category system_hardware Apr 22 10:57:03 volumio volumio[879]: info: Scanning category user_interface Apr 22 10:57:03 volumio volumio[879]: info: Plugin folders cleanup completed Apr 22 10:57:03 volumio volumio[879]: info: Error: Error Apr 22 10:57:03 volumio volumio[879]: info: Error: Error Apr 22 10:57:03 volumio volumio[879]: info: Folder /tmp/plugins removed Apr 22 10:57:03 volumio volumio[879]: info: Folder /tmp/downloaded_plugin.zip removed Apr 22 10:57:03 volumio volumio[879]: info: Folder /data/temp removed Apr 22 10:57:18 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 22 10:57:18 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 22 10:57:18 volumio volumio[879]: info: Discovery: Getting this device information Apr 22 10:57:18 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Apr 22 10:57:18 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:57:18 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 10:57:37 volumio volumio[879]: info: Starting Uninstall of plugin audio_interface - fusiondsp Apr 22 10:57:37 volumio volumio[879]: info: Uninstalling plugin fusiondsp Apr 22 10:57:37 volumio volumio[879]: info: Disabling plugin fusiondsp Apr 22 10:57:37 volumio volumio[879]: info: Preparing to generate the ALSA configuration file Apr 22 10:57:37 volumio volumio[879]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 22 10:57:37 volumio volumio[879]: info: Reading ALSA contributions from plugins. Apr 22 10:57:37 volumio volumio[879]: info: Asound.conf file unchanged, so no further update is needed Apr 22 10:57:37 volumio volumio[879]: info: Output device has changed, restarting MPD Apr 22 10:57:37 volumio sudo[1915]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 10:57:37 volumio sudo[1915]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:37 volumio volumio[879]: info: Output device has changed, restarting Shairport Sync Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:57:37 volumio sudo[1915]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:37 volumio sudo[1918]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 10:57:37 volumio sudo[1918]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:37 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 10:57:37 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:57:37 volumio volumio[879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 10:57:37 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:57:37 volumio volumio[879]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio systemd[1]: mpd.service: Succeeded. Apr 22 10:57:37 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 10:57:37 volumio vtcs[1619]: [2025-04-22 10:57:37.547] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 22 10:57:37 volumio vtcs[1619]: [2025-04-22 10:57:37.548] [tisoc] [error] [SpkconServer.cpp:380] recv error. client fd=8 errorno=104 error=Connection reset by peer Apr 22 10:57:37 volumio vtcs[1619]: [2025-04-22 10:57:37.548] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Apr 22 10:57:37 volumio systemd[1]: Starting Music Player Daemon... Apr 22 10:57:37 volumio volumio[879]: info: Checking if uninstall.sh is present Apr 22 10:57:37 volumio sudo[1927]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:57:37 volumio sudo[1927]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:37 volumio volumio[879]: info: Executing uninstall.sh Apr 22 10:57:37 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 22 10:57:37 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 22 10:57:37 volumio systemd[1]: vtcs.service: Succeeded. Apr 22 10:57:37 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 22 10:57:37 volumio sudo[1930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:57:37 volumio sudo[1930]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:37 volumio sudo[1927]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:37 volumio sudo[1930]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:37 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:57:37 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:57:37 volumio sudo[1923]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 22 10:57:37 volumio sudo[1923]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:37 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:57:37 volumio sudo[1923]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:37 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:57:37 volumio volumio[879]: info: MPD Permissions set Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio sudo[1935]: pam_unix(sudo:auth): authentication failure; logname= uid=1000 euid=0 tty= ruser=volumio rhost= user=volumio Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:37 volumio volumio[879]: info: Starting Shairport Sync Apr 22 10:57:37 volumio sudo[1944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 10:57:37 volumio sudo[1944]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 10:57:37 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 10:57:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 10:57:37 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:57:37 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:57:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 10:57:37 volumio sudo[1944]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:37 volumio volumio[879]: info: Shairport-Sync Started Apr 22 10:57:38 volumio mpd[1938]: Apr 22 10:57 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 10:57:38 volumio systemd[1]: Started Music Player Daemon. Apr 22 10:57:38 volumio sudo[1918]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:38 volumio volumio[879]: error: updateQueue error: null Apr 22 10:57:39 volumio sudo[1935]: pam_unix(sudo:auth): conversation failed Apr 22 10:57:39 volumio sudo[1935]: pam_unix(sudo:auth): auth could not identify password for [volumio] Apr 22 10:57:39 volumio sudo[1935]: volumio : 1 incorrect password attempt ; TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Apr 22 10:57:39 volumio volumio[879]: info: Uninstall script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/audio_interface/fusiondsp/uninstall.sh > /tmp/installog Apr 22 10:57:39 volumio volumio[879]: [sudo] password for volumio: Sorry, try again. Apr 22 10:57:39 volumio volumio[879]: [sudo] password for volumio: Apr 22 10:57:39 volumio volumio[879]: sudo: no password was provided Apr 22 10:57:39 volumio volumio[879]: sudo: 1 incorrect password attempt Apr 22 10:57:40 volumio volumio[879]: info: TidalConnect service stoped! Apr 22 10:57:40 volumio volumio[879]: info: TidalConnect service stoped! Apr 22 10:57:40 volumio volumio[879]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 22 10:57:40 volumio volumio[879]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 22 10:57:40 volumio sudo[1998]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 22 10:57:40 volumio sudo[1998]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:40 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 22 10:57:40 volumio sudo[1998]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:40 volumio volumio[879]: info: Executing endpoint tc_getconfig Apr 22 10:57:40 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 22 10:57:40 volumio vtcs[2000]: STARTING TidalConnect services, version: 1.5.0.45 Apr 22 10:57:41 volumio vtcs[2000]: STARTED TidalConnect services. Apr 22 10:57:41 volumio volumio[879]: info: Executing endpoint tc_connect Apr 22 10:57:41 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 22 10:57:41 volumio volumio[879]: info: Connecting to TidalConnect Apr 22 10:57:41 volumio volumio[879]: info: CoreCommandRouter::servicePushState Apr 22 10:57:41 volumio volumio[879]: info: CoreStateMachine::pushState Apr 22 10:57:41 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:57:41 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 22 10:57:41 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Apr 22 10:57:41 volumio volumio[879]: info: MRS: Pushing multiroomSync output update for this device Apr 22 10:57:41 volumio volumio[879]: info: MRS: Pushing multiroomSync output Apr 22 10:57:41 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:57:41 volumio volumio[879]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 22 10:57:41 volumio volumio[879]: info: CoreCommandRouter::servicePushState Apr 22 10:57:41 volumio volumio[879]: info: CoreStateMachine::pushState Apr 22 10:57:41 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:57:41 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Apr 22 10:57:41 volumio volumio[879]: info: MRS: Pushing multiroomSync output update for this device Apr 22 10:57:41 volumio volumio[879]: info: MRS: Pushing multiroomSync output Apr 22 10:57:41 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:57:41 volumio volumio[879]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 22 10:57:43 volumio volumio[879]: info: Executing endpoint metavolumio Apr 22 10:57:43 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 22 10:57:43 volumio volumio[879]: error: Failed request for metavolumio API Apr 22 10:57:43 volumio volumio[879]: info: TidalConnect service started! Apr 22 10:57:43 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 22 10:57:48 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Apr 22 10:57:48 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Apr 22 10:57:48 volumio volumio[879]: info: Discovery: Getting this device information Apr 22 10:57:48 volumio volumio[879]: info: CoreCommandRouter::volumioGetState Apr 22 10:57:48 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:57:48 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 10:57:55 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Apr 22 10:57:55 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Apr 22 10:57:59 volumio volumio[879]: info: Starting Uninstall of plugin audio_interface - fusiondsp Apr 22 10:57:59 volumio volumio[879]: info: Uninstalling plugin fusiondsp Apr 22 10:57:59 volumio volumio[879]: info: Disabling plugin fusiondsp Apr 22 10:57:59 volumio volumio[879]: info: Preparing to generate the ALSA configuration file Apr 22 10:57:59 volumio volumio[879]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 22 10:57:59 volumio volumio[879]: info: Reading ALSA contributions from plugins. Apr 22 10:57:59 volumio volumio[879]: info: Asound.conf file unchanged, so no further update is needed Apr 22 10:57:59 volumio volumio[879]: info: Output device has changed, restarting MPD Apr 22 10:57:59 volumio sudo[2052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 10:57:59 volumio sudo[2052]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:59 volumio volumio[879]: info: Output device has changed, restarting Shairport Sync Apr 22 10:57:59 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:59 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:57:59 volumio sudo[2052]: pam_unix(sudo:session): session closed for user root Apr 22 10:57:59 volumio sudo[2054]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 10:57:59 volumio sudo[2054]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:57:59 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 10:57:59 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:57:59 volumio volumio[879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 10:57:59 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:57:59 volumio volumio[879]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 10:57:59 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:57:59 volumio systemd[1]: mpd.service: Succeeded. Apr 22 10:57:59 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 10:57:59 volumio vtcs[2000]: [2025-04-22 10:57:59.959] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 22 10:58:00 volumio vtcs[2000]: [2025-04-22 10:57:59.960] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Apr 22 10:58:00 volumio vtcs[2000]: [2025-04-22 10:57:59.960] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Apr 22 10:58:00 volumio systemd[1]: Starting Music Player Daemon... Apr 22 10:57:59 volumio sudo[2064]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:00 volumio volumio[879]: info: Checking if uninstall.sh is present Apr 22 10:58:00 volumio volumio[879]: info: Executing uninstall.sh Apr 22 10:57:59 volumio sudo[2064]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:00 volumio sudo[2067]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:00 volumio sudo[2067]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:00 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:00 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:00 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:00 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 22 10:58:00 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 22 10:58:00 volumio systemd[1]: vtcs.service: Succeeded. Apr 22 10:58:00 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 22 10:58:00 volumio sudo[2064]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:00 volumio sudo[2071]: pam_unix(sudo:auth): authentication failure; logname= uid=1000 euid=0 tty= ruser=volumio rhost= user=volumio Apr 22 10:58:00 volumio sudo[2067]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:00 volumio volumio[879]: info: MPD Permissions set Apr 22 10:58:00 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:00 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:00 volumio sudo[2061]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 22 10:58:00 volumio sudo[2061]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio sudo[2061]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:00 volumio volumio[879]: info: Starting Shairport Sync Apr 22 10:58:00 volumio sudo[2081]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 10:58:00 volumio sudo[2081]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:00 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 10:58:00 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:00 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 10:58:00 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:00 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:00 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:00 volumio sudo[2081]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:00 volumio volumio[879]: info: Shairport-Sync Started Apr 22 10:58:00 volumio mpd[2075]: Apr 22 10:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 10:58:00 volumio systemd[1]: Started Music Player Daemon. Apr 22 10:58:00 volumio sudo[2054]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:00 volumio volumio[879]: error: updateQueue error: null Apr 22 10:58:01 volumio sudo[2071]: pam_unix(sudo:auth): conversation failed Apr 22 10:58:01 volumio sudo[2071]: pam_unix(sudo:auth): auth could not identify password for [volumio] Apr 22 10:58:01 volumio sudo[2071]: volumio : 1 incorrect password attempt ; TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Apr 22 10:58:01 volumio volumio[879]: info: Uninstall script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/audio_interface/fusiondsp/uninstall.sh > /tmp/installog Apr 22 10:58:01 volumio volumio[879]: [sudo] password for volumio: Sorry, try again. Apr 22 10:58:01 volumio volumio[879]: [sudo] password for volumio: Apr 22 10:58:01 volumio volumio[879]: sudo: no password was provided Apr 22 10:58:01 volumio volumio[879]: sudo: 1 incorrect password attempt Apr 22 10:58:03 volumio volumio[879]: info: TidalConnect service stoped! Apr 22 10:58:03 volumio volumio[879]: info: TidalConnect service stoped! Apr 22 10:58:03 volumio volumio[879]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 22 10:58:03 volumio volumio[879]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 22 10:58:03 volumio sudo[2100]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 22 10:58:03 volumio sudo[2100]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:03 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 22 10:58:03 volumio sudo[2100]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:03 volumio volumio[879]: info: Executing endpoint tc_getconfig Apr 22 10:58:03 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 22 10:58:03 volumio vtcs[2102]: STARTING TidalConnect services, version: 1.5.0.45 Apr 22 10:58:03 volumio vtcs[2102]: STARTED TidalConnect services. Apr 22 10:58:03 volumio volumio[879]: info: Executing endpoint tc_connect Apr 22 10:58:03 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 22 10:58:03 volumio volumio[879]: info: Connecting to TidalConnect Apr 22 10:58:03 volumio volumio[879]: info: CoreCommandRouter::servicePushState Apr 22 10:58:03 volumio volumio[879]: info: CoreStateMachine::pushState Apr 22 10:58:03 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:03 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Apr 22 10:58:03 volumio volumio[879]: info: MRS: Pushing multiroomSync output update for this device Apr 22 10:58:03 volumio volumio[879]: info: MRS: Pushing multiroomSync output Apr 22 10:58:03 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:03 volumio volumio[879]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 22 10:58:03 volumio volumio[879]: info: CoreCommandRouter::servicePushState Apr 22 10:58:03 volumio volumio[879]: info: CoreStateMachine::pushState Apr 22 10:58:03 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:03 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Apr 22 10:58:03 volumio volumio[879]: info: MRS: Pushing multiroomSync output update for this device Apr 22 10:58:03 volumio volumio[879]: info: MRS: Pushing multiroomSync output Apr 22 10:58:03 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:03 volumio volumio[879]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 22 10:58:05 volumio volumio[879]: info: Executing endpoint metavolumio Apr 22 10:58:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 22 10:58:05 volumio volumio[879]: info: Starting Uninstall of plugin audio_interface - fusiondsp Apr 22 10:58:05 volumio volumio[879]: info: Uninstalling plugin fusiondsp Apr 22 10:58:05 volumio volumio[879]: info: Disabling plugin fusiondsp Apr 22 10:58:05 volumio volumio[879]: info: Preparing to generate the ALSA configuration file Apr 22 10:58:05 volumio volumio[879]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 22 10:58:05 volumio volumio[879]: info: Reading ALSA contributions from plugins. Apr 22 10:58:05 volumio volumio[879]: info: Asound.conf file unchanged, so no further update is needed Apr 22 10:58:05 volumio volumio[879]: info: Output device has changed, restarting MPD Apr 22 10:58:05 volumio sudo[2137]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 10:58:05 volumio sudo[2137]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:05 volumio volumio[879]: info: Output device has changed, restarting Shairport Sync Apr 22 10:58:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:58:05 volumio sudo[2137]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:05 volumio sudo[2139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 10:58:05 volumio sudo[2139]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:05 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 10:58:05 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:58:05 volumio volumio[879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 10:58:05 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:58:05 volumio volumio[879]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 10:58:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:05 volumio systemd[1]: mpd.service: Succeeded. Apr 22 10:58:05 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 10:58:05 volumio vtcs[2102]: [2025-04-22 10:58:05.801] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 22 10:58:05 volumio vtcs[2102]: [2025-04-22 10:58:05.802] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Apr 22 10:58:05 volumio volumio[879]: info: Checking if uninstall.sh is present Apr 22 10:58:05 volumio volumio[879]: info: Executing uninstall.sh Apr 22 10:58:05 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:05 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:05 volumio volumio[879]: info: MPD Permissions set Apr 22 10:58:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:05 volumio systemd[1]: Starting Music Player Daemon... Apr 22 10:58:05 volumio sudo[2149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:05 volumio sudo[2149]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:05 volumio sudo[2152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:05 volumio sudo[2152]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:05 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 22 10:58:05 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 22 10:58:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:58:05 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:05 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:05 volumio systemd[1]: vtcs.service: Succeeded. Apr 22 10:58:05 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 22 10:58:05 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:05 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:05 volumio sudo[2152]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:05 volumio volumio[879]: info: Starting Shairport Sync Apr 22 10:58:05 volumio sudo[2149]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:05 volumio sudo[2156]: pam_unix(sudo:auth): authentication failure; logname= uid=1000 euid=0 tty= ruser=volumio rhost= user=volumio Apr 22 10:58:05 volumio sudo[2164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 10:58:05 volumio sudo[2164]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:05 volumio sudo[2146]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 22 10:58:05 volumio sudo[2146]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:05 volumio sudo[2146]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:05 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 10:58:05 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 10:58:05 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:05 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:05 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:05 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:05 volumio sudo[2164]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:05 volumio volumio[879]: info: Shairport-Sync Started Apr 22 10:58:06 volumio volumio[879]: info: TidalConnect service started! Apr 22 10:58:06 volumio mpd[2167]: Apr 22 10:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 10:58:06 volumio systemd[1]: Started Music Player Daemon. Apr 22 10:58:06 volumio sudo[2139]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:06 volumio volumio[879]: error: updateQueue error: null Apr 22 10:58:07 volumio sudo[2156]: pam_unix(sudo:auth): conversation failed Apr 22 10:58:07 volumio sudo[2156]: pam_unix(sudo:auth): auth could not identify password for [volumio] Apr 22 10:58:07 volumio sudo[2156]: volumio : 1 incorrect password attempt ; TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/sh /data/plugins/audio_interface/fusiondsp/uninstall.sh Apr 22 10:58:07 volumio volumio[879]: info: Uninstall script return the error Error: Command failed: echo volumio | sudo -S sh /data/plugins/audio_interface/fusiondsp/uninstall.sh > /tmp/installog Apr 22 10:58:07 volumio volumio[879]: [sudo] password for volumio: Sorry, try again. Apr 22 10:58:07 volumio volumio[879]: [sudo] password for volumio: Apr 22 10:58:07 volumio volumio[879]: sudo: no password was provided Apr 22 10:58:07 volumio volumio[879]: sudo: 1 incorrect password attempt Apr 22 10:58:08 volumio volumio[879]: info: TidalConnect service stoped! Apr 22 10:58:08 volumio volumio[879]: info: TidalConnect service stoped! Apr 22 10:58:08 volumio volumio[879]: info: Updating tc_getconfig REST Endpoint for plugin: music_service/tidalconnect Apr 22 10:58:08 volumio volumio[879]: info: Updating tc_connect REST Endpoint for plugin: music_service/tidalconnect Apr 22 10:58:08 volumio sudo[2182]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start vtcs.service Apr 22 10:58:08 volumio sudo[2182]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:09 volumio systemd[1]: Started Volumio Tidal Connect Service. Apr 22 10:58:09 volumio sudo[2182]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:09 volumio volumio[879]: info: Executing endpoint tc_getconfig Apr 22 10:58:09 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onGetConfig Apr 22 10:58:09 volumio vtcs[2184]: STARTING TidalConnect services, version: 1.5.0.45 Apr 22 10:58:09 volumio vtcs[2184]: STARTED TidalConnect services. Apr 22 10:58:09 volumio volumio[879]: info: Executing endpoint tc_connect Apr 22 10:58:09 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: tidalconnect , onConnect Apr 22 10:58:09 volumio volumio[879]: info: Connecting to TidalConnect Apr 22 10:58:09 volumio volumio[879]: info: CoreCommandRouter::servicePushState Apr 22 10:58:09 volumio volumio[879]: info: CoreStateMachine::pushState Apr 22 10:58:09 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:09 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Apr 22 10:58:09 volumio volumio[879]: info: MRS: Pushing multiroomSync output update for this device Apr 22 10:58:09 volumio volumio[879]: info: MRS: Pushing multiroomSync output Apr 22 10:58:09 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:09 volumio volumio[879]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 22 10:58:09 volumio volumio[879]: info: CoreCommandRouter::servicePushState Apr 22 10:58:09 volumio volumio[879]: info: CoreStateMachine::pushState Apr 22 10:58:09 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:09 volumio volumio[879]: info: CoreCommandRouter::volumioPushState Apr 22 10:58:09 volumio volumio[879]: info: MRS: Pushing multiroomSync output update for this device Apr 22 10:58:09 volumio volumio[879]: info: MRS: Pushing multiroomSync output Apr 22 10:58:09 volumio volumio[879]: info: CorePlayQueue::getTrack 0 Apr 22 10:58:09 volumio volumio[879]: info: Received update from a service different from the one supposed to be playing music. Skipping notification.Current webradio Received tidalconnect Apr 22 10:58:10 volumio volumio[879]: info: Enabling plugin fusiondsp Apr 22 10:58:10 volumio volumio[879]: info: Loading plugin "fusiondsp"... Apr 22 10:58:10 volumio volumio[879]: info: Applying required configuration parameters for plugin fusiondsp Apr 22 10:58:10 volumio volumio[879]: info: Preparing to generate the ALSA configuration file Apr 22 10:58:10 volumio volumio[879]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 22 10:58:10 volumio volumio[879]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 22 10:58:10 volumio volumio[879]: info: Reading ALSA contributions from plugins. Apr 22 10:58:10 volumio volumio[879]: info: Asound.conf file written Apr 22 10:58:10 volumio sudo[2204]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Apr 22 10:58:10 volumio sudo[2204]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio sudo[2204]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:10 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:58:10 volumio volumio[879]: info: Output device has changed, restarting MPD Apr 22 10:58:10 volumio sudo[2209]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 10:58:10 volumio sudo[2209]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio volumio[879]: info: Output device has changed, restarting Shairport Sync Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:58:10 volumio sudo[2209]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:10 volumio sudo[2212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 10:58:10 volumio sudo[2212]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio systemd[1]: Stopping Music Player Daemon... Apr 22 10:58:10 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:58:10 volumio volumio[879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 10:58:10 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:58:10 volumio volumio[879]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio systemd[1]: mpd.service: Succeeded. Apr 22 10:58:10 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 10:58:10 volumio vtcs[2184]: [2025-04-22 10:58:10.779] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Apr 22 10:58:10 volumio vtcs[2184]: [2025-04-22 10:58:10.779] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Apr 22 10:58:10 volumio vtcs[2184]: [2025-04-22 10:58:10.779] [tisoc] [error] [SpkconServer.cpp:472] socket write error. fd=3 errorno=32 error=Broken pipe Apr 22 10:58:10 volumio systemd[1]: Starting Music Player Daemon... Apr 22 10:58:10 volumio sudo[2221]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:10 volumio volumio[879]: info: PLUGIN START: fusiondsp Apr 22 10:58:10 volumio volumio[879]: info: Loading i18n strings for locale en Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: FusionDsp - mixtype--------------------- Hardware Apr 22 10:58:10 volumio volumio[879]: info: Preparing to generate the ALSA configuration file Apr 22 10:58:10 volumio sudo[2221]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio volumio[879]: info: Done. Apr 22 10:58:10 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Apr 22 10:58:10 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Apr 22 10:58:10 volumio systemd[1]: vtcs.service: Succeeded. Apr 22 10:58:10 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Apr 22 10:58:10 volumio sudo[2221]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:10 volumio volumio[879]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Apr 22 10:58:10 volumio volumio[879]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 22 10:58:10 volumio volumio[879]: info: Reading ALSA contributions from plugins. Apr 22 10:58:10 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:10 volumio sudo[2224]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:10 volumio sudo[2224]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:10 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:10 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:10 volumio volumio[879]: info: MPD Permissions set Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio sudo[2224]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:10 volumio sudo[2218]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 22 10:58:10 volumio sudo[2218]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio sudo[2218]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: Starting Shairport Sync Apr 22 10:58:10 volumio volumio[879]: info: Asound.conf file unchanged, so no further update is needed Apr 22 10:58:10 volumio volumio[879]: info: Output device has changed, restarting MPD Apr 22 10:58:10 volumio sudo[2235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 10:58:10 volumio sudo[2235]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio sudo[2238]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 22 10:58:10 volumio sudo[2238]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:10 volumio volumio[879]: info: Output device has changed, restarting Shairport Sync Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:10 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:58:10 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 10:58:10 volumio sudo[2238]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:10 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 10:58:10 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:10 volumio sudo[2241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 22 10:58:10 volumio sudo[2241]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:11 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:58:11 volumio volumio[879]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 22 10:58:11 volumio volumio[879]: xcb_connection_has_error() returned true Apr 22 10:58:11 volumio volumio[879]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio sudo[2235]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:11 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Apr 22 10:58:11 volumio systemd[1]: mpd.service: Succeeded. Apr 22 10:58:11 volumio systemd[1]: Stopped Music Player Daemon. Apr 22 10:58:11 volumio sudo[2251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:11 volumio systemd[1]: Starting Music Player Daemon... Apr 22 10:58:11 volumio sudo[2251]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:11 volumio sudo[2256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Apr 22 10:58:11 volumio sudo[2256]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:11 volumio volumio[879]: info: MPD Permissions set Apr 22 10:58:11 volumio volumio[879]: info: Shairport-Sync Started Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio sudo[2251]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:11 volumio sudo[2256]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:11 volumio volumio[879]: info: Starting Shairport Sync Apr 22 10:58:11 volumio sudo[2253]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 22 10:58:11 volumio sudo[2253]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:11 volumio sudo[2253]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:11 volumio sudo[2266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 22 10:58:11 volumio sudo[2266]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:11 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 22 10:58:11 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 22 10:58:11 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: running Apr 22 10:58:11 volumio volumio[879]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Apr 22 10:58:11 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 22 10:58:11 volumio sudo[2266]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:11 volumio volumio[879]: info: Shairport-Sync Started Apr 22 10:58:11 volumio volumio[879]: info: Executing endpoint metavolumio Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: metavolumio , requestToMetaVolumio Apr 22 10:58:11 volumio mpd[2267]: Apr 22 10:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 22 10:58:11 volumio systemd[1]: Started Music Player Daemon. Apr 22 10:58:11 volumio sudo[2212]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:11 volumio sudo[2241]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:11 volumio volumio[879]: error: MPD error: The expression evaluated to a falsy value: Apr 22 10:58:11 volumio volumio[879]: assert.ok(self.idling) Apr 22 10:58:11 volumio volumio[879]: error: The expression evaluated to a falsy value: Apr 22 10:58:11 volumio volumio[879]: assert.ok(self.idling) Apr 22 10:58:11 volumio volumio[879]: error: updateQueue error: null Apr 22 10:58:11 volumio volumio[879]: info: CoreCommandRouter::getUIConfigOnPlugin Apr 22 10:58:11 volumio volumio[879]: info: FusionDsp - Apr 22 10:58:12 volumio volumio[879]: info: FusionDsp - undefined Apr 22 10:58:12 volumio volumio[879]: info: TidalConnect service started! Apr 22 10:58:12 volumio volumio[879]: info: camilladsp service started and running in background, instance 1 Apr 22 10:58:12 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 22 10:58:12 volumio volumio[879]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 22 10:58:12 volumio volumio[879]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 22 10:58:12 volumio volumio[879]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 22 10:58:12 volumio volumio[879]: info: FusionDsp loaded Apr 22 10:58:12 volumio volumio[879]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 22 10:58:12 volumio sudo[2284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 22 10:58:12 volumio sudo[2284]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 22 10:58:12 volumio volumio[879]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 22 10:58:12 volumio volumio[879]: info: Adding Signal Path Element [object Object] Apr 22 10:58:12 volumio volumio[879]: info: Adding fusiondspeq DSP Signal Path Element Apr 22 10:58:12 volumio volumio[879]: info: FusionDsp - ---- installed callbackRead Apr 22 10:58:12 volumio volumio[879]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 10:58:12 volumio volumio[879]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 22 10:58:12 volumio volumio[879]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Apr 22 10:58:12 volumio volumio[879]: at onErrorNT (internal/child_process.js:465:16) Apr 22 10:58:12 volumio volumio[879]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Apr 22 10:58:12 volumio volumio[879]: errno: -2, Apr 22 10:58:12 volumio volumio[879]: code: 'ENOENT', Apr 22 10:58:12 volumio volumio[879]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 22 10:58:12 volumio volumio[879]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 22 10:58:12 volumio volumio[879]: spawnargs: [ Apr 22 10:58:12 volumio volumio[879]: '-p', Apr 22 10:58:12 volumio volumio[879]: 9876, Apr 22 10:58:12 volumio volumio[879]: '-o', Apr 22 10:58:12 volumio volumio[879]: '/tmp/camilladsp.log', Apr 22 10:58:12 volumio volumio[879]: '-l', Apr 22 10:58:12 volumio volumio[879]: 'warn', Apr 22 10:58:12 volumio volumio[879]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 22 10:58:12 volumio volumio[879]: ] Apr 22 10:58:12 volumio volumio[879]: } Apr 22 10:58:12 volumio volumio[879]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 22 10:58:12 volumio systemd[1]: Started FusionDsp Daemon. Apr 22 10:58:12 volumio sudo[2284]: pam_unix(sudo:session): session closed for user root Apr 22 10:58:13 volumio volumio[2286]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Apr 22 10:58:13 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Apr 22 10:58:13 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 22 10:58:13 volumio sudo[2296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-22 10:57 Apr 22 10:58:13 volumio sudo[2296]: 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="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"