-- Logs begin at Thu 2024-02-22 07:42:47 +11, end at Sun 2024-03-31 17:42:18 +11. --
Mar 31 17:41:25 volumio volumio[758]: info: Selecting previously unselected package libpython3-dev:armhf.
Mar 31 17:41:25 volumio volumio[758]: info: Selecting previously unselected package libpython3-dev:armhf.
Mar 31 17:41:25 volumio volumio[758]: info: Preparing to unpack .../32-libpython3-dev_3.7.3-1_armhf.deb ...
Mar 31 17:41:25 volumio volumio[758]: info: Preparing to unpack .../32-libpython3-dev_3.7.3-1_armhf.deb ...
Mar 31 17:41:25 volumio volumio[758]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ...
Mar 31 17:41:25 volumio volumio[758]: info: Unpacking libpython3-dev:armhf (3.7.3-1) ...
Mar 31 17:41:26 volumio volumio[758]: info: Selecting previously unselected package python-pip-whl.
Mar 31 17:41:26 volumio volumio[758]: info: Selecting previously unselected package python-pip-whl.
Mar 31 17:41:26 volumio volumio[758]: info: Preparing to unpack .../33-python-pip-whl_18.1-5+rpt1_all.deb ...
Mar 31 17:41:26 volumio volumio[758]: info: Unpacking python-pip-whl (18.1-5+rpt1) ...
Mar 31 17:41:26 volumio volumio[758]: info: Preparing to unpack .../33-python-pip-whl_18.1-5+rpt1_all.deb ...
Mar 31 17:41:26 volumio volumio[758]: info: Unpacking python-pip-whl (18.1-5+rpt1) ...
Mar 31 17:41:28 volumio volumio[758]: info: Selecting previously unselected package python3-multidict.
Mar 31 17:41:28 volumio volumio[758]: info: Selecting previously unselected package python3-multidict.
Mar 31 17:41:28 volumio volumio[758]: info: Preparing to unpack .../34-python3-multidict_4.5.2-1_armhf.deb ...
Mar 31 17:41:28 volumio volumio[758]: info: Preparing to unpack .../34-python3-multidict_4.5.2-1_armhf.deb ...
Mar 31 17:41:28 volumio volumio[758]: info: Unpacking python3-multidict (4.5.2-1) ...
Mar 31 17:41:28 volumio volumio[758]: info: Unpacking python3-multidict (4.5.2-1) ...
Mar 31 17:41:29 volumio volumio[758]: info: Selecting previously unselected package python3-yarl.
Mar 31 17:41:29 volumio volumio[758]: info: Selecting previously unselected package python3-yarl.
Mar 31 17:41:29 volumio volumio[758]: info: Preparing to unpack .../35-python3-yarl_1.3.0-1_armhf.deb ...
Mar 31 17:41:29 volumio volumio[758]: info: Preparing to unpack .../35-python3-yarl_1.3.0-1_armhf.deb ...
Mar 31 17:41:29 volumio volumio[758]: info: Unpacking python3-yarl (1.3.0-1) ...
Mar 31 17:41:29 volumio volumio[758]: info: Unpacking python3-yarl (1.3.0-1) ...
Mar 31 17:41:30 volumio volumio[758]: info: Selecting previously unselected package python3-async-timeout.
Mar 31 17:41:30 volumio volumio[758]: info: Selecting previously unselected package python3-async-timeout.
Mar 31 17:41:30 volumio volumio[758]: info: Preparing to unpack .../36-python3-async-timeout_3.0.1-1_all.deb ...
Mar 31 17:41:30 volumio volumio[758]: info: Preparing to unpack .../36-python3-async-timeout_3.0.1-1_all.deb ...
Mar 31 17:41:30 volumio volumio[758]: info: Unpacking python3-async-timeout (3.0.1-1) ...
Mar 31 17:41:30 volumio volumio[758]: info: Unpacking python3-async-timeout (3.0.1-1) ...
Mar 31 17:41:30 volumio volumio[758]: info: Selecting previously unselected package python3-attr.
Mar 31 17:41:30 volumio volumio[758]: info: Selecting previously unselected package python3-attr.
Mar 31 17:41:30 volumio volumio[758]: info: Preparing to unpack .../37-python3-attr_18.2.0-1_all.deb ...
Mar 31 17:41:30 volumio volumio[758]: info: Preparing to unpack .../37-python3-attr_18.2.0-1_all.deb ...
Mar 31 17:41:30 volumio volumio[758]: info: Unpacking python3-attr (18.2.0-1) ...
Mar 31 17:41:30 volumio volumio[758]: info: Unpacking python3-attr (18.2.0-1) ...
Mar 31 17:41:31 volumio volumio[758]: info: Selecting previously unselected package python3-aiohttp.
Mar 31 17:41:31 volumio volumio[758]: info: Selecting previously unselected package python3-aiohttp.
Mar 31 17:41:31 volumio volumio[758]: info: Preparing to unpack .../38-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ...
Mar 31 17:41:31 volumio volumio[758]: info: Preparing to unpack .../38-python3-aiohttp_3.5.1-1+deb10u1_armhf.deb ...
Mar 31 17:41:32 volumio volumio[758]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ...
Mar 31 17:41:32 volumio volumio[758]: info: Unpacking python3-aiohttp (3.5.1-1+deb10u1) ...
Mar 31 17:41:36 volumio volumio[758]: info: Selecting previously unselected package python3-asn1crypto.
Mar 31 17:41:36 volumio volumio[758]: info: Selecting previously unselected package python3-asn1crypto.
Mar 31 17:41:36 volumio volumio[758]: info: Preparing to unpack .../39-python3-asn1crypto_0.24.0-1_all.deb ...
Mar 31 17:41:36 volumio volumio[758]: info: Unpacking python3-asn1crypto (0.24.0-1) ...
Mar 31 17:41:36 volumio volumio[758]: info: Preparing to unpack .../39-python3-asn1crypto_0.24.0-1_all.deb ...
Mar 31 17:41:36 volumio volumio[758]: info: Unpacking python3-asn1crypto (0.24.0-1) ...
Mar 31 17:41:37 volumio volumio[758]: info: Selecting previously unselected package python3-cffi-backend.
Mar 31 17:41:37 volumio volumio[758]: info: Selecting previously unselected package python3-cffi-backend.
Mar 31 17:41:37 volumio volumio[758]: info: Preparing to unpack .../40-python3-cffi-backend_1.12.2-1_armhf.deb ...
Mar 31 17:41:37 volumio volumio[758]: info: Preparing to unpack .../40-python3-cffi-backend_1.12.2-1_armhf.deb ...
Mar 31 17:41:37 volumio volumio[758]: info: Unpacking python3-cffi-backend (1.12.2-1) ...
Mar 31 17:41:37 volumio volumio[758]: info: Unpacking python3-cffi-backend (1.12.2-1) ...
Mar 31 17:41:37 volumio volumio[758]: info: Selecting previously unselected package python3-crypto.
Mar 31 17:41:37 volumio volumio[758]: info: Selecting previously unselected package python3-crypto.
Mar 31 17:41:37 volumio volumio[758]: info: Preparing to unpack .../41-python3-crypto_2.6.1-9+b1_armhf.deb ...
Mar 31 17:41:37 volumio volumio[758]: info: Preparing to unpack .../41-python3-crypto_2.6.1-9+b1_armhf.deb ...
Mar 31 17:41:37 volumio volumio[758]: info: Unpacking python3-crypto (2.6.1-9+b1) ...
Mar 31 17:41:37 volumio volumio[758]: info: Unpacking python3-crypto (2.6.1-9+b1) ...
Mar 31 17:41:44 volumio ntpd[657]: Soliciting pool server 2404:2a00::30
Mar 31 17:41:45 volumio systemd[1]: Starting Cleanup of Temporary Directories...
Mar 31 17:41:45 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:41:45 volumio systemd[1]: systemd-tmpfiles-clean.service: Succeeded.
Mar 31 17:41:45 volumio systemd[1]: Started Cleanup of Temporary Directories.
Mar 31 17:41:51 volumio volumio[758]: info: Selecting previously unselected package python3-cryptography.
Mar 31 17:41:51 volumio volumio[758]: info: Selecting previously unselected package python3-cryptography.
Mar 31 17:41:51 volumio volumio[758]: info: Preparing to unpack .../42-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ...
Mar 31 17:41:51 volumio volumio[758]: info: Preparing to unpack .../42-python3-cryptography_2.6.1-3+deb10u4_armhf.deb ...
Mar 31 17:41:51 volumio volumio[758]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ...
Mar 31 17:41:51 volumio volumio[758]: info: Unpacking python3-cryptography (2.6.1-3+deb10u4) ...
Mar 31 17:41:58 volumio volumio[758]: info: Selecting previously unselected package python3-dbus.
Mar 31 17:41:58 volumio volumio[758]: info: Selecting previously unselected package python3-dbus.
Mar 31 17:41:58 volumio volumio[758]: info: Preparing to unpack .../43-python3-dbus_1.2.8-3_armhf.deb ...
Mar 31 17:41:58 volumio volumio[758]: info: Unpacking python3-dbus (1.2.8-3) ...
Mar 31 17:41:58 volumio volumio[758]: info: Preparing to unpack .../43-python3-dbus_1.2.8-3_armhf.deb ...
Mar 31 17:41:58 volumio volumio[758]: info: Unpacking python3-dbus (1.2.8-3) ...
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3.7-dev.
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3.7-dev.
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../44-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ...
Mar 31 17:41:59 volumio volumio[758]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ...
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../44-python3.7-dev_3.7.3-2+deb10u7_armhf.deb ...
Mar 31 17:41:59 volumio volumio[758]: info: Unpacking python3.7-dev (3.7.3-2+deb10u7) ...
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3-dev.
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3-dev.
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../45-python3-dev_3.7.3-1_armhf.deb ...
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../45-python3-dev_3.7.3-1_armhf.deb ...
Mar 31 17:41:59 volumio volumio[758]: info: Unpacking python3-dev (3.7.3-1) ...
Mar 31 17:41:59 volumio volumio[758]: info: Unpacking python3-dev (3.7.3-1) ...
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3-entrypoints.
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3-entrypoints.
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../46-python3-entrypoints_0.3-1_all.deb ...
Mar 31 17:41:59 volumio volumio[758]: info: Unpacking python3-entrypoints (0.3-1) ...
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../46-python3-entrypoints_0.3-1_all.deb ...
Mar 31 17:41:59 volumio volumio[758]: info: Unpacking python3-entrypoints (0.3-1) ...
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3-gi.
Mar 31 17:41:59 volumio volumio[758]: info: Selecting previously unselected package python3-gi.
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../47-python3-gi_3.30.4-1_armhf.deb ...
Mar 31 17:41:59 volumio volumio[758]: info: Preparing to unpack .../47-python3-gi_3.30.4-1_armhf.deb ...
Mar 31 17:42:00 volumio volumio[758]: info: Unpacking python3-gi (3.30.4-1) ...
Mar 31 17:42:00 volumio volumio[758]: info: Unpacking python3-gi (3.30.4-1) ...
Mar 31 17:42:01 volumio volumio[758]: info: Selecting previously unselected package python3-secretstorage.
Mar 31 17:42:01 volumio volumio[758]: info: Selecting previously unselected package python3-secretstorage.
Mar 31 17:42:01 volumio volumio[758]: info: Preparing to unpack .../48-python3-secretstorage_2.3.1-2_all.deb ...
Mar 31 17:42:01 volumio volumio[758]: info: Preparing to unpack .../48-python3-secretstorage_2.3.1-2_all.deb ...
Mar 31 17:42:01 volumio volumio[758]: info: Unpacking python3-secretstorage (2.3.1-2) ...
Mar 31 17:42:01 volumio volumio[758]: info: Unpacking python3-secretstorage (2.3.1-2) ...
Mar 31 17:42:02 volumio volumio[758]: info: Selecting previously unselected package python3-keyring.
Mar 31 17:42:02 volumio volumio[758]: info: Selecting previously unselected package python3-keyring.
Mar 31 17:42:02 volumio volumio[758]: info: Preparing to unpack .../49-python3-keyring_17.1.1-1_all.deb ...
Mar 31 17:42:02 volumio volumio[758]: info: Preparing to unpack .../49-python3-keyring_17.1.1-1_all.deb ...
Mar 31 17:42:02 volumio volumio[758]: info: Unpacking python3-keyring (17.1.1-1) ...
Mar 31 17:42:02 volumio volumio[758]: info: Unpacking python3-keyring (17.1.1-1) ...
Mar 31 17:42:03 volumio volumio[758]: info: Selecting previously unselected package python3-keyrings.alt.
Mar 31 17:42:03 volumio volumio[758]: info: Selecting previously unselected package python3-keyrings.alt.
Mar 31 17:42:03 volumio volumio[758]: info: Preparing to unpack .../50-python3-keyrings.alt_3.1.1-1_all.deb ...
Mar 31 17:42:03 volumio volumio[758]: info: Preparing to unpack .../50-python3-keyrings.alt_3.1.1-1_all.deb ...
Mar 31 17:42:03 volumio volumio[758]: info: Unpacking python3-keyrings.alt (3.1.1-1) ...
Mar 31 17:42:03 volumio volumio[758]: info: Unpacking python3-keyrings.alt (3.1.1-1) ...
Mar 31 17:42:03 volumio volumio[758]: info: Selecting previously unselected package python3-pip.
Mar 31 17:42:03 volumio volumio[758]: info: Selecting previously unselected package python3-pip.
Mar 31 17:42:03 volumio volumio[758]: info: Preparing to unpack .../51-python3-pip_18.1-5+rpt1_all.deb ...
Mar 31 17:42:03 volumio volumio[758]: info: Preparing to unpack .../51-python3-pip_18.1-5+rpt1_all.deb ...
Mar 31 17:42:03 volumio volumio[758]: info: Unpacking python3-pip (18.1-5+rpt1) ...
Mar 31 17:42:03 volumio volumio[758]: info: Unpacking python3-pip (18.1-5+rpt1) ...
Mar 31 17:42:06 volumio volumio[758]: info: Selecting previously unselected package python3-setuptools.
Mar 31 17:42:06 volumio volumio[758]: info: Selecting previously unselected package python3-setuptools.
Mar 31 17:42:06 volumio volumio[758]: info: Preparing to unpack .../52-python3-setuptools_40.8.0-1_all.deb ...
Mar 31 17:42:06 volumio volumio[758]: info: Preparing to unpack .../52-python3-setuptools_40.8.0-1_all.deb ...
Mar 31 17:42:07 volumio volumio[758]: info: Unpacking python3-setuptools (40.8.0-1) ...
Mar 31 17:42:07 volumio volumio[758]: info: Unpacking python3-setuptools (40.8.0-1) ...
Mar 31 17:42:09 volumio volumio[758]: info: Selecting previously unselected package python3-wheel.
Mar 31 17:42:10 volumio volumio[758]: info: Selecting previously unselected package python3-wheel.
Mar 31 17:42:10 volumio volumio[758]: info: Preparing to unpack .../53-python3-wheel_0.32.3-2_all.deb ...
Mar 31 17:42:10 volumio volumio[758]: info: Preparing to unpack .../53-python3-wheel_0.32.3-2_all.deb ...
Mar 31 17:42:10 volumio volumio[758]: info: Unpacking python3-wheel (0.32.3-2) ...
Mar 31 17:42:10 volumio volumio[758]: info: Unpacking python3-wheel (0.32.3-2) ...
Mar 31 17:42:11 volumio volumio[758]: info: Selecting previously unselected package python3-xdg.
Mar 31 17:42:11 volumio volumio[758]: info: Selecting previously unselected package python3-xdg.
Mar 31 17:42:11 volumio volumio[758]: info: Preparing to unpack .../54-python3-xdg_0.25-5_all.deb ...
Mar 31 17:42:11 volumio volumio[758]: info: Preparing to unpack .../54-python3-xdg_0.25-5_all.deb ...
Mar 31 17:42:11 volumio volumio[758]: info: Unpacking python3-xdg (0.25-5) ...
Mar 31 17:42:11 volumio volumio[758]: info: Unpacking python3-xdg (0.25-5) ...
Mar 31 17:42:13 volumio volumio[758]: info: Setting up python3-entrypoints (0.3-1) ...
Mar 31 17:42:13 volumio volumio[758]: info: Setting up python3-entrypoints (0.3-1) ...
Mar 31 17:42:15 volumio volumio[758]: info: Setting up dh-python (3.20190308) ...
Mar 31 17:42:15 volumio volumio[758]: info: Setting up dh-python (3.20190308) ...
Mar 31 17:42:15 volumio volumio[758]: info: Enabling plugin fusiondsp
Mar 31 17:42:15 volumio volumio[758]: info: Loading plugin "fusiondsp"...
Mar 31 17:42:15 volumio volumio[758]: info: Preparing to generate the ALSA configuration file
Mar 31 17:42:15 volumio volumio[758]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Mar 31 17:42:15 volumio volumio[758]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Mar 31 17:42:15 volumio volumio[758]: info: Reading ALSA contributions from plugins.
Mar 31 17:42:15 volumio volumio[758]: info: Asound.conf file written
Mar 31 17:42:15 volumio sudo[4276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf
Mar 31 17:42:15 volumio sudo[4276]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:15 volumio sudo[4276]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:15 volumio volumio[758]: xcb_connection_has_error() returned true
Mar 31 17:42:15 volumio volumio[758]: No state is present for card b1
Mar 31 17:42:15 volumio volumio[758]: /usr/share/alsa/init/bcm2835:14: control element not found
Mar 31 17:42:15 volumio volumio[758]: No state is present for card b1
Mar 31 17:42:15 volumio volumio[758]: No state is present for card Headphones
Mar 31 17:42:15 volumio volumio[758]: /usr/share/alsa/init/bcm2835:20: control element not found
Mar 31 17:42:15 volumio volumio[758]: No state is present for card Headphones
Mar 31 17:42:15 volumio volumio[758]: No state is present for card sndallodigione
Mar 31 17:42:15 volumio volumio[758]: Found hardware: "RPi-WM8804" "" "" "" ""
Mar 31 17:42:15 volumio volumio[758]: Hardware is initialized using a generic method
Mar 31 17:42:15 volumio volumio[758]: No state is present for card sndallodigione
Mar 31 17:42:15 volumio volumio[758]: info: Output device has changed, restarting MPD
Mar 31 17:42:15 volumio sudo[4284]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 31 17:42:15 volumio sudo[4284]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:15 volumio volumio[758]: info: Output device has changed, restarting Shairport Sync
Mar 31 17:42:15 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:15 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 17:42:15 volumio sudo[4284]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:15 volumio sudo[4287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 31 17:42:15 volumio sudo[4287]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:15 volumio systemd[1]: Stopping Music Player Daemon...
Mar 31 17:42:15 volumio volumio[758]: xcb_connection_has_error() returned true
Mar 31 17:42:15 volumio volumio[758]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 31 17:42:15 volumio volumio[758]: xcb_connection_has_error() returned true
Mar 31 17:42:15 volumio volumio[758]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Mar 31 17:42:15 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:15 volumio systemd[1]: mpd.service: Succeeded.
Mar 31 17:42:15 volumio systemd[1]: Stopped Music Player Daemon.
Mar 31 17:42:15 volumio vtcs[2778]: [2024-03-31 17:42:15.811] [tisoc] [warning] [SessionManagerImpl.cpp:243] Illegal State: IDLE
Mar 31 17:42:15 volumio vtcs[2778]: [2024-03-31 17:42:15.815] [tisoc] [error] [SpkconServer.cpp:382] recv error. client fd=8 errorno=104 error=Connection reset by peer
Mar 31 17:42:15 volumio vtcs[2778]: [2024-03-31 17:42:15.815] [tisoc] [error] [SpkconServer.cpp:377] recv error. socket disconnected
Mar 31 17:42:15 volumio systemd[1]: Starting Music Player Daemon...
Mar 31 17:42:15 volumio sudo[4296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Mar 31 17:42:15 volumio volumio[758]: info: PLUGIN START: fusiondsp
Mar 31 17:42:15 volumio volumio[758]: info: Loading i18n strings for locale fr
Mar 31 17:42:15 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Mar 31 17:42:15 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:15 volumio volumio[758]: info: FusionDsp - mixtype--------------------- Software
Mar 31 17:42:15 volumio volumio[758]: info: Preparing to generate the ALSA configuration file
Mar 31 17:42:15 volumio volumio[758]: info: Done.
Mar 31 17:42:15 volumio sudo[4296]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:15 volumio systemd[1]: Stopping Volumio Tidal Connect Service...
Mar 31 17:42:15 volumio systemd[1]: vtcs.service: Main process exited, code=killed, status=15/TERM
Mar 31 17:42:15 volumio volumio[758]: info: The plugin alsa_controller has an ALSA contribution file softvolume.postVolume.conf
Mar 31 17:42:15 volumio volumio[758]: info: The plugin multiroom has an ALSA contribution file volumioMultiRoomServer.postMultiRoom.1000.conf
Mar 31 17:42:15 volumio volumio[758]: info: Reading ALSA contributions from plugins.
Mar 31 17:42:15 volumio systemd[1]: vtcs.service: Succeeded.
Mar 31 17:42:15 volumio systemd[1]: Stopped Volumio Tidal Connect Service.
Mar 31 17:42:15 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:42:15 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Mar 31 17:42:15 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:42:15 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:42:15 volumio sudo[4296]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:15 volumio volumio[758]: info: MPD Permissions set
Mar 31 17:42:15 volumio sudo[4310]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Mar 31 17:42:15 volumio sudo[4310]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:15 volumio volumio[758]: info: CoreCommandRouter::getUIConfigOnPlugin
Mar 31 17:42:15 volumio volumio[758]: info: Setting up python3-attr (18.2.0-1) ...
Mar 31 17:42:15 volumio sudo[4310]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:16 volumio volumio[758]: info: Setting up python3-attr (18.2.0-1) ...
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: Starting Shairport Sync
Mar 31 17:42:16 volumio sudo[4322]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 31 17:42:16 volumio sudo[4322]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Mar 31 17:42:16 volumio systemd[1]: shairport-sync.service: Succeeded.
Mar 31 17:42:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Mar 31 17:42:16 volumio volumio[758]: info: Asound.conf file unchanged, so no further update is needed
Mar 31 17:42:16 volumio volumio[758]: info: Output device has changed, restarting MPD
Mar 31 17:42:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 31 17:42:16 volumio sudo[4322]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:16 volumio volumio[758]: info: Output device has changed, restarting Shairport Sync
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 17:42:16 volumio sudo[4327]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Mar 31 17:42:16 volumio sudo[4327]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:16 volumio sudo[4330]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Mar 31 17:42:16 volumio sudo[4330]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:16 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Mar 31 17:42:16 volumio systemd[1]: mpd.service: Succeeded.
Mar 31 17:42:16 volumio systemd[1]: Stopped Music Player Daemon.
Mar 31 17:42:16 volumio systemd[1]: Starting Music Player Daemon...
Mar 31 17:42:16 volumio volumio[758]: xcb_connection_has_error() returned true
Mar 31 17:42:16 volumio volumio[758]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Mar 31 17:42:16 volumio volumio[758]: xcb_connection_has_error() returned true
Mar 31 17:42:16 volumio volumio[758]: info: MRS: Audio Device Changed, rebuilding Multiroom Configuration
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio sudo[4342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Mar 31 17:42:16 volumio sudo[4342]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:16 volumio sudo[4344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop vtcs.service
Mar 31 17:42:16 volumio sudo[4344]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:16 volumio sudo[4327]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:42:16 volumio volumio[758]: info: Shairport-Sync Started
Mar 31 17:42:16 volumio sudo[4344]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:16 volumio sudo[4342]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:16 volumio volumio[758]: info: MPD Permissions set
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:16 volumio volumio[758]: info: Setting up python3-dbus (1.2.8-3) ...
Mar 31 17:42:16 volumio volumio[758]: info: Setting up python3-dbus (1.2.8-3) ...
Mar 31 17:42:16 volumio volumio[758]: info: Starting Shairport Sync
Mar 31 17:42:16 volumio sudo[4379]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Mar 31 17:42:16 volumio sudo[4379]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Mar 31 17:42:16 volumio systemd[1]: shairport-sync.service: Succeeded.
Mar 31 17:42:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: running
Mar 31 17:42:16 volumio volumio[758]: ------------------------------------ BT MESSAGE: BT STATUS: waiting
Mar 31 17:42:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Mar 31 17:42:16 volumio sudo[4379]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:16 volumio volumio[758]: info: Shairport-Sync Started
Mar 31 17:42:17 volumio mpd[4338]: Mar 31 17:42 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Mar 31 17:42:17 volumio systemd[1]: Started Music Player Daemon.
Mar 31 17:42:17 volumio sudo[4287]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:17 volumio sudo[4330]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:17 volumio volumio[758]: error: MPD error: The expression evaluated to a falsy value:
Mar 31 17:42:17 volumio volumio[758]: assert.ok(self.idling)
Mar 31 17:42:17 volumio volumio[758]: error: The expression evaluated to a falsy value:
Mar 31 17:42:17 volumio volumio[758]: assert.ok(self.idling)
Mar 31 17:42:17 volumio volumio[758]: error: updateQueue error: null
Mar 31 17:42:17 volumio volumio[758]: info: Setting up python3-setuptools (40.8.0-1) ...
Mar 31 17:42:17 volumio volumio[758]: info: Setting up python3-setuptools (40.8.0-1) ...
Mar 31 17:42:17 volumio volumio[758]: info: camilladsp spawned new process with pid undefined, instance 1, run: true
Mar 31 17:42:17 volumio volumio[758]: info: camilladsp service started and running in background, instance 1
Mar 31 17:42:17 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Mar 31 17:42:17 volumio volumio[758]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Mar 31 17:42:17 volumio volumio[758]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Mar 31 17:42:17 volumio volumio[758]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Mar 31 17:42:17 volumio volumio[758]: info: FusionDsp loaded
Mar 31 17:42:17 volumio volumio[758]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Mar 31 17:42:17 volumio sudo[4444]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Mar 31 17:42:17 volumio sudo[4444]: pam_unix(sudo:session): session opened for user root by (uid=0)
Mar 31 17:42:17 volumio volumio[758]: info: FusionDsp - Reporting Fusion DSP Enabled
Mar 31 17:42:17 volumio volumio[758]: info: Adding Signal Path Element [object Object]
Mar 31 17:42:17 volumio volumio[758]: info: Adding fusiondspeq DSP Signal Path Element
Mar 31 17:42:17 volumio volumio[758]: info: FusionDsp - ---- installed callbackRead
Mar 31 17:42:17 volumio volumio[758]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 31 17:42:17 volumio volumio[758]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Mar 31 17:42:17 volumio volumio[758]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Mar 31 17:42:17 volumio volumio[758]: at onErrorNT (internal/child_process.js:465:16)
Mar 31 17:42:17 volumio volumio[758]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Mar 31 17:42:17 volumio volumio[758]: errno: -2,
Mar 31 17:42:17 volumio volumio[758]: code: 'ENOENT',
Mar 31 17:42:17 volumio volumio[758]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Mar 31 17:42:17 volumio volumio[758]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Mar 31 17:42:17 volumio volumio[758]: spawnargs: [
Mar 31 17:42:17 volumio volumio[758]: '-p',
Mar 31 17:42:17 volumio volumio[758]: 9876,
Mar 31 17:42:17 volumio volumio[758]: '-o',
Mar 31 17:42:17 volumio volumio[758]: '/tmp/camilladsp.log',
Mar 31 17:42:17 volumio volumio[758]: '-l',
Mar 31 17:42:17 volumio volumio[758]: 'warn',
Mar 31 17:42:17 volumio volumio[758]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Mar 31 17:42:17 volumio volumio[758]: ]
Mar 31 17:42:17 volumio volumio[758]: }
Mar 31 17:42:17 volumio volumio[758]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Mar 31 17:42:17 volumio sudo[4444]: pam_unix(sudo:session): session closed for user root
Mar 31 17:42:18 volumio sudo[4456]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-03-31 17:41
Mar 31 17:42:18 volumio sudo[4456]: 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="7f9f1bf001add7a8b19a4516e3c74ef598b2730d"
VOLUMIO_FE_VERSION="614d7b13ffdcb0cc5a6072e7d06f59d52e323e71"
VOLUMIO_FE3_VERSION="570aaed971c1346d45d1172dc445b086b258c6d1"
VOLUMIO_BE_VERSION="512433c3e91cdaed7ecd2808b21adeffc2137d7f"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Wed 21 Feb 2024 09:37:22 PM CET"
VOLUMIO_VERSION="3.631"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="fdd9dd1169c06c1ad0a30ddd24c91b6b"