-- Logs begin at Fri 2025-10-31 08:47:47 CET, end at Fri 2025-10-31 08:58:53 CET. -- Oct 31 08:57:14 volumio volumio[1310]: info: Fetched 80.4 MB in 1min 4s (1254 kB/s) Oct 31 08:57:14 volumio volumio[1310]: info: Selecting previously unselected package bzip2. Oct 31 08:57:14 volumio volumio[1310]: [620B blob data] Oct 31 08:57:14 volumio volumio[1310]: info: Preparing to unpack .../00-bzip2_1.0.6-9.2~deb10u2_armhf.deb ... Oct 31 08:57:14 volumio volumio[1310]: info: Unpacking bzip2 (1.0.6-9.2~deb10u2) ... Oct 31 08:57:28 volumio volumio[1310]: info: Selecting previously unselected package libisl19:armhf. Oct 31 08:57:28 volumio volumio[1310]: info: Preparing to unpack .../01-libisl19_0.20-2_armhf.deb ... Oct 31 08:57:28 volumio volumio[1310]: info: Unpacking libisl19:armhf (0.20-2) ... Oct 31 08:57:30 volumio volumio[1310]: info: Selecting previously unselected package libmpfr6:armhf. Oct 31 08:57:30 volumio volumio[1310]: info: Preparing to unpack .../02-libmpfr6_4.0.2-1_armhf.deb ... Oct 31 08:57:31 volumio volumio[1310]: info: Unpacking libmpfr6:armhf (4.0.2-1) ... Oct 31 08:57:33 volumio volumio[1310]: info: Selecting previously unselected package libmpc3:armhf. Oct 31 08:57:33 volumio volumio[1310]: info: Preparing to unpack .../03-libmpc3_1.1.0-1_armhf.deb ... Oct 31 08:57:34 volumio volumio[1310]: info: Unpacking libmpc3:armhf (1.1.0-1) ... Oct 31 08:57:36 volumio volumio[1310]: info: Selecting previously unselected package cpp-8. Oct 31 08:57:36 volumio volumio[1310]: info: Preparing to unpack .../04-cpp-8_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:57:36 volumio volumio[1310]: info: Unpacking cpp-8 (8.3.0-6+rpi1) ... Oct 31 08:57:44 volumio volumio[1310]: info: Selecting previously unselected package cpp. Oct 31 08:57:44 volumio volumio[1310]: info: Preparing to unpack .../05-cpp_4%3a8.3.0-1+rpi2_armhf.deb ... Oct 31 08:57:44 volumio volumio[1310]: info: Unpacking cpp (4:8.3.0-1+rpi2) ... Oct 31 08:57:50 volumio volumio[1310]: info: Selecting previously unselected package libcc1-0:armhf. Oct 31 08:57:50 volumio volumio[1310]: info: Preparing to unpack .../06-libcc1-0_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:57:50 volumio volumio[1310]: info: Unpacking libcc1-0:armhf (8.3.0-6+rpi1) ... Oct 31 08:57:50 volumio volumio[1310]: info: Selecting previously unselected package libasan5:armhf. Oct 31 08:57:50 volumio volumio[1310]: info: Preparing to unpack .../07-libasan5_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:57:50 volumio volumio[1310]: info: Unpacking libasan5:armhf (8.3.0-6+rpi1) ... Oct 31 08:57:51 volumio volumio[1310]: info: Selecting previously unselected package libubsan1:armhf. Oct 31 08:57:51 volumio volumio[1310]: info: Preparing to unpack .../08-libubsan1_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:57:51 volumio volumio[1310]: info: Unpacking libubsan1:armhf (8.3.0-6+rpi1) ... Oct 31 08:57:52 volumio volumio[1310]: info: Selecting previously unselected package libgcc-8-dev:armhf. Oct 31 08:57:52 volumio volumio[1310]: info: Preparing to unpack .../09-libgcc-8-dev_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:57:53 volumio volumio[1310]: info: Unpacking libgcc-8-dev:armhf (8.3.0-6+rpi1) ... Oct 31 08:57:57 volumio volumio[1310]: info: Selecting previously unselected package gcc-8. Oct 31 08:57:57 volumio volumio[1310]: info: Preparing to unpack .../10-gcc-8_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:57:57 volumio volumio[1310]: info: Unpacking gcc-8 (8.3.0-6+rpi1) ... Oct 31 08:57:59 volumio volumio[1310]: info: Selecting previously unselected package gcc. Oct 31 08:57:59 volumio volumio[1310]: info: Preparing to unpack .../11-gcc_4%3a8.3.0-1+rpi2_armhf.deb ... Oct 31 08:57:59 volumio volumio[1310]: info: Unpacking gcc (4:8.3.0-1+rpi2) ... Oct 31 08:57:59 volumio volumio[1310]: info: Selecting previously unselected package libstdc++-8-dev:armhf. Oct 31 08:57:59 volumio volumio[1310]: info: Preparing to unpack .../12-libstdc++-8-dev_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:57:59 volumio volumio[1310]: info: Unpacking libstdc++-8-dev:armhf (8.3.0-6+rpi1) ... Oct 31 08:58:42 volumio volumio[1310]: verbose: New Socket.io Connection to 192.168.178.140 from 192.168.178.218 UA: Mozilla/5.0 (Linux; Android 15; 24030PN60G Build/AQ3A.240627.003; wv) AppleWebKit/537.36 (KHTML, like Gecko) Version/4.0 Chrome/141.0.7390.122 Mobile Safari/537.36 Engine version: 3 Transport: polling Total Clients: 5 Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::volumioGetVisibleSources Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::volumioGetState Oct 31 08:58:42 volumio volumio[1310]: info: CorePlayQueue::getTrack 0 Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Oct 31 08:58:42 volumio volumio[1310]: info: Error : CoreCommandRouter::executeOnPlugin: No method [getMultiroom] in plugin multiroom Oct 31 08:58:42 volumio volumio[1310]: info: Received Get System Info Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Oct 31 08:58:42 volumio volumio[1310]: info: Discovery: Getting this device information Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::volumioGetState Oct 31 08:58:42 volumio volumio[1310]: info: CorePlayQueue::getTrack 0 Oct 31 08:58:42 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 08:58:43 volumio volumio[1310]: info: CoreCommandRouter::volumioGetState Oct 31 08:58:43 volumio volumio[1310]: info: CorePlayQueue::getTrack 0 Oct 31 08:58:43 volumio volumio[1310]: info: Listing playlists Oct 31 08:58:43 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Oct 31 08:58:45 volumio volumio[1310]: verbose: New Socket.io Connection to 192.168.178.140:3000 from 192.168.178.218 UA: Dart/3.5 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Oct 31 08:58:46 volumio volumio[1310]: info: Selecting previously unselected package g++-8. Oct 31 08:58:46 volumio volumio[1310]: info: Preparing to unpack .../13-g++-8_8.3.0-6+rpi1_armhf.deb ... Oct 31 08:58:47 volumio volumio[1310]: info: Unpacking g++-8 (8.3.0-6+rpi1) ... Oct 31 08:58:51 volumio volumio[1310]: info: Enabling plugin fusiondsp Oct 31 08:58:51 volumio volumio[1310]: info: Loading plugin "fusiondsp"... Oct 31 08:58:51 volumio volumio[1310]: info: Preparing to generate the ALSA configuration file Oct 31 08:58:51 volumio volumio[1310]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 31 08:58:51 volumio volumio[1310]: info: Reading ALSA contributions from plugins. Oct 31 08:58:51 volumio volumio[1310]: info: Asound.conf file unchanged, so no further update is needed Oct 31 08:58:51 volumio volumio[1310]: info: Output device has changed, restarting MPD Oct 31 08:58:51 volumio sudo[4191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 31 08:58:51 volumio sudo[4191]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio sudo[4191]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio volumio[1310]: info: Output device has changed, restarting Shairport Sync Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 08:58:51 volumio sudo[4194]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 31 08:58:51 volumio sudo[4194]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio systemd[1]: Stopping Music Player Daemon... Oct 31 08:58:51 volumio volumio[1310]: xcb_connection_has_error() returned true Oct 31 08:58:51 volumio systemd[1]: mpd.service: Succeeded. Oct 31 08:58:51 volumio volumio[1310]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 31 08:58:51 volumio volumio[1310]: xcb_connection_has_error() returned true Oct 31 08:58:51 volumio systemd[1]: Stopped Music Player Daemon. Oct 31 08:58:51 volumio volumio[1310]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: QobuzConnect: setDeactiveState invoked Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::volumioGetState Oct 31 08:58:51 volumio volumio[1310]: info: CorePlayQueue::getTrack 0 Oct 31 08:58:51 volumio vtcs[1750]: [2025-10-31 08:58:51.504] [tisoc] [warning] [SessionManagerImpl.cpp:240] Illegal State: IDLE Oct 31 08:58:51 volumio vtcs[1750]: [2025-10-31 08:58:51.504] [tisoc] [error] [SpkconServer.cpp:375] recv error. socket disconnected Oct 31 08:58:51 volumio volumio[1310]: info: PLUGIN START: fusiondsp Oct 31 08:58:51 volumio volumio[1310]: info: Loading i18n strings for locale nl Oct 31 08:58:51 volumio systemd[1]: Starting Music Player Daemon... Oct 31 08:58:51 volumio sudo[4203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - mixtype--------------------- Hardware Oct 31 08:58:51 volumio sudo[4203]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio volumio[1310]: info: Preparing to generate the ALSA configuration file Oct 31 08:58:51 volumio volumio[1310]: info: Done. Oct 31 08:58:51 volumio systemd[1]: Stopping Volumio Tidal Connect Service... Oct 31 08:58:51 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM Oct 31 08:58:51 volumio systemd[1]: vtcs.service: Succeeded. Oct 31 08:58:51 volumio systemd[1]: Stopped Volumio Tidal Connect Service. Oct 31 08:58:51 volumio sudo[4203]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4208]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 31 08:58:51 volumio sudo[4208]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio sudo[4199]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 31 08:58:51 volumio sudo[4199]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio sudo[4199]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4208]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio volumio[1310]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf Oct 31 08:58:51 volumio volumio[1310]: info: Reading ALSA contributions from plugins. Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 08:58:51 volumio sudo[4217]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 31 08:58:51 volumio sudo[4217]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: info: MPD Permissions set Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio sudo[4217]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4219]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 31 08:58:51 volumio sudo[4219]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: Starting Shairport Sync Oct 31 08:58:51 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Oct 31 08:58:51 volumio qobuz-connect[1716]: 20251031 08:58:51.581 [1716.1716] INFO SampleApp: Stopping Local configuration server Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 08:58:51 volumio qobuz-connect[1716]: 20251031 08:58:51.591 [1716.1716] INFO SampleApp: shat down connection on UNIX socket Oct 31 08:58:51 volumio sudo[4226]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 31 08:58:51 volumio sudo[4226]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::getUIConfigOnPlugin Oct 31 08:58:51 volumio volumio[1310]: info: QobuzConnect: Qobuz Connect client [object Object] disconnected Oct 31 08:58:51 volumio volumio[1310]: info: QobuzConnect: setDeactiveState invoked Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::volumioGetState Oct 31 08:58:51 volumio volumio[1310]: info: CorePlayQueue::getTrack 0 Oct 31 08:58:51 volumio volumio[1310]: info: Asound.conf file unchanged, so no further update is needed Oct 31 08:58:51 volumio volumio[1310]: info: Output device has changed, restarting MPD Oct 31 08:58:51 volumio systemd[1]: qobuz-connect.service: Succeeded. Oct 31 08:58:51 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Oct 31 08:58:51 volumio sudo[4230]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Oct 31 08:58:51 volumio sudo[4230]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio volumio[1310]: info: Output device has changed, restarting Shairport Sync Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 08:58:51 volumio systemd[1]: Started Volumio Qobuz Connect Service. Oct 31 08:58:51 volumio sudo[4230]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Oct 31 08:58:51 volumio sudo[4233]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 31 08:58:51 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 31 08:58:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 31 08:58:51 volumio sudo[4219]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 31 08:58:51 volumio sudo[4226]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Oct 31 08:58:51 volumio systemd[1]: mpd.service: Succeeded. Oct 31 08:58:51 volumio systemd[1]: Stopped Music Player Daemon. Oct 31 08:58:51 volumio systemd[1]: Starting Music Player Daemon... Oct 31 08:58:51 volumio volumio[1310]: xcb_connection_has_error() returned true Oct 31 08:58:51 volumio volumio[1310]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Oct 31 08:58:51 volumio volumio[1310]: xcb_connection_has_error() returned true Oct 31 08:58:51 volumio volumio[1310]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: QobuzConnect: setDeactiveState invoked Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::volumioGetState Oct 31 08:58:51 volumio volumio[1310]: info: CorePlayQueue::getTrack 0 Oct 31 08:58:51 volumio sudo[4241]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Oct 31 08:58:51 volumio sudo[4241]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio sudo[4247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 31 08:58:51 volumio sudo[4241]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4247]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio sudo[4250]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service Oct 31 08:58:51 volumio sudo[4250]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: info: MPD Permissions set Oct 31 08:58:51 volumio volumio[1310]: info: Shairport-Sync Started Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - Oct 31 08:58:51 volumio sudo[4258]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl reset-failed qobuz-connect.service Oct 31 08:58:51 volumio sudo[4258]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio sudo[4258]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4260]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart qobuz-connect.service Oct 31 08:58:51 volumio sudo[4250]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4260]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio sudo[4247]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio systemd[1]: Stopping Volumio Qobuz Connect Service... Oct 31 08:58:51 volumio systemd[1]: qobuz-connect.service: Main process exited, code=killed, status=2/INT Oct 31 08:58:51 volumio systemd[1]: qobuz-connect.service: Succeeded. Oct 31 08:58:51 volumio systemd[1]: Stopped Volumio Qobuz Connect Service. Oct 31 08:58:51 volumio systemd[1]: Started Volumio Qobuz Connect Service. Oct 31 08:58:51 volumio sudo[4260]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - Oct 31 08:58:51 volumio volumio[1310]: info: Executing endpoint qc_getconfig Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - undefined Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - undefined Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - undefined Oct 31 08:58:51 volumio volumio[1310]: info: FusionDsp - undefined Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:51 volumio volumio[1310]: info: Executing endpoint qc_getconfig Oct 31 08:58:51 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: qobuzconnect , onGetConfig Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.916 [4264.4264] INFO SampleApp: Started connection to /tmp/qbz-connect.socket UNIX socket Oct 31 08:58:51 volumio volumio[1310]: info: QobuzConnect: Qobuz Connect socket /tmp/qbz-connect.socket connected to client [object Object] Oct 31 08:58:51 volumio volumio[1310]: info: QobuzConnect: QOBUZ Connect daemon connected Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.918 [4264.4264] INFO VolumeManager: [0x1538aa0]: Setting new playback volume: 75 Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.918 [4264.4264] INFO VolumeManager: [0x1538aa0]: Setting new mute state: 0 Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.918 [4264.4264] INFO QobuzConnect: [0x1539470]: Client initialized! Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.918 [4264.4264] INFO SampleApp: Starting Avahi advertising, name: Volumio, service name: _qobuz-connect._tcp Oct 31 08:58:51 volumio volumio[1310]: info: Starting Shairport Sync Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.921 [4264.4264] INFO LocalConfigManager: [0x1538380]: Starting Local Configuration server Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.921 [4264.4264] INFO SampleApp: Starting Local configuration server Oct 31 08:58:51 volumio qobuz-connect[4264]: 20251031 08:58:51.922 [4264.4264] INFO SampleApp: Connected to UNIX socket client 0x152df60 Oct 31 08:58:51 volumio sudo[4286]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Oct 31 08:58:51 volumio sudo[4286]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:51 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Oct 31 08:58:51 volumio systemd[1]: shairport-sync.service: Succeeded. Oct 31 08:58:51 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: running Oct 31 08:58:51 volumio volumio[1310]: ------------------------------------ BT MESSAGE: BT STATUS: waiting Oct 31 08:58:51 volumio mpd[4253]: Oct 31 08:58 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Oct 31 08:58:51 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Oct 31 08:58:51 volumio systemd[1]: Started Music Player Daemon. Oct 31 08:58:51 volumio sudo[4233]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4194]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio sudo[4286]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:51 volumio volumio[1310]: info: Shairport-Sync Started Oct 31 08:58:51 volumio volumio[1310]: error: MPD error: The expression evaluated to a falsy value: Oct 31 08:58:51 volumio volumio[1310]: assert.ok(self.idling) Oct 31 08:58:51 volumio volumio[1310]: error: The expression evaluated to a falsy value: Oct 31 08:58:51 volumio volumio[1310]: assert.ok(self.idling) Oct 31 08:58:51 volumio volumio[1310]: error: updateQueue error: null Oct 31 08:58:52 volumio volumio[1310]: info: Selecting previously unselected package g++. Oct 31 08:58:52 volumio volumio[1310]: info: Preparing to unpack .../14-g++_4%3a8.3.0-1+rpi2_armhf.deb ... Oct 31 08:58:52 volumio volumio[1310]: info: Unpacking g++ (4:8.3.0-1+rpi2) ... Oct 31 08:58:52 volumio qobuz-connect[4264]: 20251031 08:58:52.066 [4264.4264] INFO SampleApp: Playback volume changed: 75 Oct 31 08:58:52 volumio volumio[1310]: info: CoreCommandRouter::volumioGetState Oct 31 08:58:52 volumio volumio[1310]: info: CorePlayQueue::getTrack 0 Oct 31 08:58:52 volumio volumio[1310]: info: Selecting previously unselected package make. Oct 31 08:58:52 volumio volumio[1310]: info: Preparing to unpack .../15-make_4.2.1-1.2_armhf.deb ... Oct 31 08:58:52 volumio volumio[1310]: info: Unpacking make (4.2.1-1.2) ... Oct 31 08:58:52 volumio volumio[1310]: info: Selecting previously unselected package patch. Oct 31 08:58:52 volumio volumio[1310]: info: Preparing to unpack .../16-patch_2.7.6-3+deb10u1_armhf.deb ... Oct 31 08:58:52 volumio volumio[1310]: info: Unpacking patch (2.7.6-3+deb10u1) ... Oct 31 08:58:53 volumio volumio[1310]: info: camilladsp service started and running in background, instance 1 Oct 31 08:58:53 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Oct 31 08:58:53 volumio volumio[1310]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 31 08:58:53 volumio volumio[1310]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Oct 31 08:58:53 volumio volumio[1310]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Oct 31 08:58:53 volumio volumio[1310]: info: FusionDsp loaded Oct 31 08:58:53 volumio volumio[1310]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Oct 31 08:58:53 volumio sudo[4382]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Oct 31 08:58:53 volumio sudo[4382]: pam_unix(sudo:session): session opened for user root by (uid=0) Oct 31 08:58:53 volumio volumio[1310]: info: FusionDsp - Reporting Fusion DSP Enabled Oct 31 08:58:53 volumio volumio[1310]: info: Adding Signal Path Element [object Object] Oct 31 08:58:53 volumio volumio[1310]: info: Adding fusiondspeq DSP Signal Path Element Oct 31 08:58:53 volumio volumio[1310]: info: FusionDsp - ---- installed callbackRead Oct 31 08:58:53 volumio volumio[1310]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 08:58:53 volumio volumio[1310]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Oct 31 08:58:53 volumio volumio[1310]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Oct 31 08:58:53 volumio volumio[1310]: at onErrorNT (internal/child_process.js:465:16) Oct 31 08:58:53 volumio volumio[1310]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Oct 31 08:58:53 volumio volumio[1310]: errno: -2, Oct 31 08:58:53 volumio volumio[1310]: code: 'ENOENT', Oct 31 08:58:53 volumio volumio[1310]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Oct 31 08:58:53 volumio volumio[1310]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Oct 31 08:58:53 volumio volumio[1310]: spawnargs: [ Oct 31 08:58:53 volumio volumio[1310]: '-p', Oct 31 08:58:53 volumio volumio[1310]: 9876, Oct 31 08:58:53 volumio volumio[1310]: '-o', Oct 31 08:58:53 volumio volumio[1310]: '/tmp/camilladsp.log', Oct 31 08:58:53 volumio volumio[1310]: '-l', Oct 31 08:58:53 volumio volumio[1310]: 'warn', Oct 31 08:58:53 volumio volumio[1310]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Oct 31 08:58:53 volumio volumio[1310]: ] Oct 31 08:58:53 volumio volumio[1310]: } Oct 31 08:58:53 volumio volumio[1310]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Oct 31 08:58:53 volumio sudo[4382]: pam_unix(sudo:session): session closed for user root Oct 31 08:58:53 volumio sudo[4393]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-10-31 08:57 Oct 31 08:58:53 volumio sudo[4393]: 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"