-- Logs begin at Thu 2019-02-14 11:12:00 CET, end at Fri 2024-08-30 19:56:04 CEST. -- Aug 30 19:55:00 volumio-socrates volumio[942]: info: CALLMETHOD: system_controller system enableSSH true Aug 30 19:55:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , enableSSH Aug 30 19:55:00 volumio-socrates sudo[9858]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start ssh.service Aug 30 19:55:00 volumio-socrates sudo[9858]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:55:00 volumio-socrates sudo[9858]: pam_unix(sudo:session): session closed for user root Aug 30 19:55:00 volumio-socrates sudo[9860]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl enable ssh.service Aug 30 19:55:00 volumio-socrates sudo[9860]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:55:00 volumio-socrates systemd[1]: Reloading. Aug 30 19:55:01 volumio-socrates systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 30 19:55:02 volumio-socrates systemd[1]: Reloading. Aug 30 19:55:02 volumio-socrates systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 30 19:55:02 volumio-socrates systemd[1]: Reloading. Aug 30 19:55:03 volumio-socrates systemd[1]: /lib/systemd/system/winbind.service:8: PIDFile= references path below legacy directory /var/run/, updating /var/run/samba/winbindd.pid → /run/samba/winbindd.pid; please update the unit file accordingly. Aug 30 19:55:03 volumio-socrates sudo[9860]: pam_unix(sudo:session): session closed for user root Aug 30 19:55:03 volumio-socrates volumio[942]: info: enable SSH service success Aug 30 19:55:04 volumio-socrates volumio[942]: info: Looking in indexes: https://pypi.org/simple, https://www.piwheels.org/simple Aug 30 19:55:04 volumio-socrates volumio[942]: info: Collecting git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 Aug 30 19:55:04 volumio-socrates volumio[942]: info: Cloning https://github.com/HEnquist/pycamilladsp-plot.git (to revision v1.0.2) to /tmp/pip-req-build-zweh8jwb Aug 30 19:55:07 volumio-socrates volumio[942]: info: Requirement already satisfied (use --upgrade to upgrade): camilladsp-plot==1.0.2 from git+https://github.com/HEnquist/pycamilladsp-plot.git@v1.0.2 in /usr/local/lib/python3.7/dist-packages Aug 30 19:55:07 volumio-socrates volumio[942]: info: Requirement already satisfied: PyYAML in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (6.0.1) Aug 30 19:55:07 volumio-socrates volumio[942]: info: Requirement already satisfied: jsonschema in /usr/local/lib/python3.7/dist-packages (from camilladsp-plot==1.0.2) (4.17.3) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Requirement already satisfied: attrs>=17.4.0 in /usr/lib/python3/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (18.2.0) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Requirement already satisfied: pyrsistent!=0.17.0,!=0.17.1,!=0.17.2,>=0.14.0 in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (0.19.3) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Requirement already satisfied: importlib-metadata; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (6.7.0) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Requirement already satisfied: importlib-resources>=1.4.0; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (5.12.0) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Requirement already satisfied: typing-extensions; python_version < "3.8" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (4.7.1) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Requirement already satisfied: pkgutil-resolve-name>=1.3.10; python_version < "3.9" in /usr/local/lib/python3.7/dist-packages (from jsonschema->camilladsp-plot==1.0.2) (1.3.10) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Requirement already satisfied: zipp>=0.5 in /usr/local/lib/python3.7/dist-packages (from importlib-metadata; python_version < "3.8"->jsonschema->camilladsp-plot==1.0.2) (3.15.0) Aug 30 19:55:08 volumio-socrates volumio[942]: info: Building wheels for collected packages: camilladsp-plot Aug 30 19:55:08 volumio-socrates volumio[942]: info: Running setup.py bdist_wheel for camilladsp-plot: started Aug 30 19:55:10 volumio-socrates volumio[942]: info: Running setup.py bdist_wheel for camilladsp-plot: finished with status 'done' Aug 30 19:55:10 volumio-socrates volumio[942]: info: Stored in directory: /tmp/pip-ephem-wheel-cache-0i5pc7cs/wheels/11/e1/43/8275af2f537d569c7097d202b4955f9aec629859be39dab2e9 Aug 30 19:55:10 volumio-socrates volumio[942]: info: Successfully built camilladsp-plot Aug 30 19:55:11 volumio-socrates volumio[942]: info: copying hw detection script Aug 30 19:55:11 volumio-socrates volumio[942]: info: Detected cpu architecture as armv7l Aug 30 19:55:27 volumio-socrates sshd[9937]: Accepted password for volumio from 192.168.1.118 port 57049 ssh2 Aug 30 19:55:27 volumio-socrates sshd[9937]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Aug 30 19:55:27 volumio-socrates systemd[1]: Created slice User Slice of UID 1000. Aug 30 19:55:27 volumio-socrates systemd[1]: Starting User Runtime Directory /run/user/1000... Aug 30 19:55:27 volumio-socrates systemd-logind[604]: New session 3 of user volumio. Aug 30 19:55:27 volumio-socrates systemd[1]: Started User Runtime Directory /run/user/1000. Aug 30 19:55:27 volumio-socrates systemd[1]: Starting User Manager for UID 1000... Aug 30 19:55:27 volumio-socrates systemd[10005]: pam_unix(systemd-user:session): session opened for user volumio by (uid=0) Aug 30 19:55:27 volumio-socrates sshd[10002]: Accepted password for volumio from 192.168.1.118 port 57054 ssh2 Aug 30 19:55:27 volumio-socrates sshd[10002]: pam_unix(sshd:session): session opened for user volumio by (uid=0) Aug 30 19:55:27 volumio-socrates systemd-logind[604]: New session 5 of user volumio. Aug 30 19:55:27 volumio-socrates systemd[10005]: Reached target Paths. Aug 30 19:55:27 volumio-socrates systemd[10005]: Reached target Timers. Aug 30 19:55:27 volumio-socrates systemd[10005]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Aug 30 19:55:27 volumio-socrates systemd[10005]: Listening on GnuPG network certificate management daemon. Aug 30 19:55:27 volumio-socrates systemd[10005]: Listening on GnuPG cryptographic agent and passphrase cache. Aug 30 19:55:27 volumio-socrates systemd[10005]: Listening on GnuPG cryptographic agent and passphrase cache (restricted). Aug 30 19:55:27 volumio-socrates systemd[10005]: Listening on Sound System. Aug 30 19:55:27 volumio-socrates systemd[10005]: Starting D-Bus User Message Bus Socket. Aug 30 19:55:27 volumio-socrates systemd[10005]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Aug 30 19:55:27 volumio-socrates systemd[10005]: Listening on D-Bus User Message Bus Socket. Aug 30 19:55:27 volumio-socrates systemd[10005]: Reached target Sockets. Aug 30 19:55:27 volumio-socrates systemd[10005]: Reached target Basic System. Aug 30 19:55:27 volumio-socrates systemd[1]: Started User Manager for UID 1000. Aug 30 19:55:27 volumio-socrates systemd[10005]: Starting Music Player Daemon... Aug 30 19:55:27 volumio-socrates systemd[1]: Started Session 5 of user volumio. Aug 30 19:55:27 volumio-socrates systemd[1]: Started Session 3 of user volumio. Aug 30 19:55:28 volumio-socrates sshd[10031]: error: Failed to allocate internet-domain X11 display socket. Aug 30 19:55:31 volumio-socrates mpd[10016]: exception: failed to open log file "/var/log/mpd.log" (config line 7): Permission denied Aug 30 19:55:31 volumio-socrates systemd[10005]: mpd.service: Main process exited, code=exited, status=1/FAILURE Aug 30 19:55:31 volumio-socrates systemd[10005]: mpd.service: Failed with result 'exit-code'. Aug 30 19:55:31 volumio-socrates systemd[10005]: Failed to start Music Player Daemon. Aug 30 19:55:31 volumio-socrates systemd[10005]: Reached target Default. Aug 30 19:55:31 volumio-socrates systemd[10005]: Startup finished in 3.897s. Aug 30 19:55:32 volumio-socrates sudo[10057]: volumio : TTY=pts/0 ; PWD=/home/volumio ; USER=root ; COMMAND=/bin/journalctl -fe Aug 30 19:55:32 volumio-socrates sudo[10057]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Aug 30 19:55:48 volumio-socrates sudo[10163]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Aug 30 19:55:48 volumio-socrates sudo[10163]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:55:48 volumio-socrates sudo[10163]: pam_unix(sudo:session): session closed for user root Aug 30 19:55:48 volumio-socrates sudo[10166]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Aug 30 19:55:48 volumio-socrates sudo[10166]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:55:48 volumio-socrates sudo[10166]: pam_unix(sudo:session): session closed for user root Aug 30 19:55:49 volumio-socrates volumio[942]: verbose: New Socket.io Connection to 192.168.1.121 from 192.168.1.118 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:129.0) Gecko/20100101 Firefox/129.0 Engine version: 3 Transport: polling Total Clients: 8 Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::volumioGetVisibleSources Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::volumioGetState Aug 30 19:55:49 volumio-socrates volumio[942]: info: CorePlayQueue::getTrack 0 Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Aug 30 19:55:49 volumio-socrates volumio[942]: info: Received Get System Info Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:55:49 volumio-socrates volumio[942]: info: Discovery: Getting this device information Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::volumioGetState Aug 30 19:55:49 volumio-socrates volumio[942]: info: CorePlayQueue::getTrack 0 Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::volumioGetState Aug 30 19:55:49 volumio-socrates volumio[942]: info: CorePlayQueue::getTrack 0 Aug 30 19:55:49 volumio-socrates volumio[942]: info: Listing playlists Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: appearance , getUiSettings Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getPrivacySettings Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioToken Aug 30 19:55:49 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: updater_comm , getUpdateMessageCache Aug 30 19:55:50 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:55:50 volumio-socrates volumio[942]: info: Received Get System Info Aug 30 19:55:50 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:55:50 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:55:50 volumio-socrates volumio[942]: info: Discovery: Getting this device information Aug 30 19:55:50 volumio-socrates volumio[942]: info: CoreCommandRouter::volumioGetState Aug 30 19:55:50 volumio-socrates volumio[942]: info: CorePlayQueue::getTrack 0 Aug 30 19:55:50 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:55:51 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: wizard , getOnboardingWizard Aug 30 19:55:51 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Aug 30 19:55:51 volumio-socrates volumio[942]: info: Received Get System Info Aug 30 19:55:51 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Aug 30 19:55:51 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Aug 30 19:55:51 volumio-socrates volumio[942]: info: Discovery: Getting this device information Aug 30 19:55:51 volumio-socrates volumio[942]: info: CoreCommandRouter::volumioGetState Aug 30 19:55:51 volumio-socrates volumio[942]: info: CorePlayQueue::getTrack 0 Aug 30 19:55:51 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:55:58 volumio-socrates volumio[942]: info: Enabling plugin fusiondsp Aug 30 19:55:58 volumio-socrates volumio[942]: info: Loading plugin "fusiondsp"... Aug 30 19:55:58 volumio-socrates volumio[942]: info: Applying required configuration parameters for plugin fusiondsp Aug 30 19:55:59 volumio-socrates volumio[942]: info: Preparing to generate the ALSA configuration file Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: appearance , isLatestTOSAccepted Aug 30 19:55:59 volumio-socrates volumio[942]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Aug 30 19:55:59 volumio-socrates volumio[942]: info: Reading ALSA contributions from plugins. Aug 30 19:55:59 volumio-socrates volumio[942]: info: Asound.conf file unchanged, so no further update is needed Aug 30 19:55:59 volumio-socrates volumio[942]: info: Output device has changed, restarting MPD Aug 30 19:55:59 volumio-socrates sudo[10231]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 19:55:59 volumio-socrates sudo[10231]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:55:59 volumio-socrates sudo[10231]: pam_unix(sudo:session): session closed for user root Aug 30 19:55:59 volumio-socrates volumio[942]: info: Output device has changed, restarting Shairport Sync Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:55:59 volumio-socrates sudo[10235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 19:55:59 volumio-socrates sudo[10235]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:55:59 volumio-socrates systemd[1]: Stopping Music Player Daemon... Aug 30 19:55:59 volumio-socrates systemd[1]: mpd.service: Succeeded. Aug 30 19:55:59 volumio-socrates systemd[1]: Stopped Music Player Daemon. Aug 30 19:55:59 volumio-socrates volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 19:55:59 volumio-socrates systemd[1]: Starting Music Player Daemon... Aug 30 19:55:59 volumio-socrates volumio[942]: info: PLUGIN START: fusiondsp Aug 30 19:55:59 volumio-socrates volumio[942]: info: Loading i18n strings for locale en Aug 30 19:55:59 volumio-socrates volumio[942]: info: Plugin peppyspectrum has duplicated i18n key APPLY. It is ignored. Aug 30 19:55:59 volumio-socrates volumio[942]: info: Plugin peppyspectrum has duplicated i18n key SAVE. It is ignored. Aug 30 19:55:59 volumio-socrates volumio[942]: info: Plugin peppyspectrum has duplicated i18n key CLICK_TO_UPDATE_LIST. It is ignored. Aug 30 19:55:59 volumio-socrates volumio[942]: info: Plugin peppyspectrum has duplicated i18n key LIST_SUCCESS_UPDATED. It is ignored. Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: FusionDsp - mixtype--------------------- Hardware Aug 30 19:55:59 volumio-socrates volumio[942]: info: Preparing to generate the ALSA configuration file Aug 30 19:55:59 volumio-socrates volumio[942]: info: Done. Aug 30 19:55:59 volumio-socrates volumio[942]: info: The plugin peppyspectrum has an ALSA contribution file peppy_in.peppy_out.6.conf Aug 30 19:55:59 volumio-socrates volumio[942]: info: Reading ALSA contributions from plugins. Aug 30 19:55:59 volumio-socrates volumio[942]: info: MPD Permissions set Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::volumioGetState Aug 30 19:55:59 volumio-socrates volumio[942]: info: CorePlayQueue::getTrack 0 Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:55:59 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:55:59 volumio-socrates sudo[10240]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 19:55:59 volumio-socrates sudo[10240]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:55:59 volumio-socrates sudo[10240]: pam_unix(sudo:session): session closed for user root Aug 30 19:55:59 volumio-socrates volumio[942]: info: Starting Shairport Sync Aug 30 19:56:00 volumio-socrates sudo[10253]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 19:56:00 volumio-socrates sudo[10253]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::getUIConfigOnPlugin Aug 30 19:56:00 volumio-socrates systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 19:56:00 volumio-socrates volumio[942]: info: Asound.conf file unchanged, so no further update is needed Aug 30 19:56:00 volumio-socrates volumio[942]: info: Output device has changed, restarting MPD Aug 30 19:56:00 volumio-socrates systemd[1]: shairport-sync.service: Succeeded. Aug 30 19:56:00 volumio-socrates systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 19:56:00 volumio-socrates volumio[942]: info: Output device has changed, restarting Shairport Sync Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:56:00 volumio-socrates sudo[10256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Aug 30 19:56:00 volumio-socrates sudo[10256]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:56:00 volumio-socrates systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 19:56:00 volumio-socrates sudo[10256]: pam_unix(sudo:session): session closed for user root Aug 30 19:56:00 volumio-socrates sudo[10264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Aug 30 19:56:00 volumio-socrates sudo[10264]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:56:00 volumio-socrates sudo[10253]: pam_unix(sudo:session): session closed for user root Aug 30 19:56:00 volumio-socrates volumio[942]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Aug 30 19:56:00 volumio-socrates systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Aug 30 19:56:00 volumio-socrates systemd[1]: mpd.service: Succeeded. Aug 30 19:56:00 volumio-socrates systemd[1]: Stopped Music Player Daemon. Aug 30 19:56:00 volumio-socrates volumio[942]: info: MPD Permissions set Aug 30 19:56:00 volumio-socrates volumio[942]: info: Shairport-Sync Started Aug 30 19:56:00 volumio-socrates systemd[1]: Starting Music Player Daemon... Aug 30 19:56:00 volumio-socrates sudo[10272]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Aug 30 19:56:00 volumio-socrates sudo[10272]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:56:00 volumio-socrates sudo[10272]: pam_unix(sudo:session): session closed for user root Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:00 volumio-socrates volumio[942]: info: Starting Shairport Sync Aug 30 19:56:00 volumio-socrates sudo[10281]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Aug 30 19:56:00 volumio-socrates sudo[10281]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:56:00 volumio-socrates systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Aug 30 19:56:00 volumio-socrates systemd[1]: shairport-sync.service: Succeeded. Aug 30 19:56:00 volumio-socrates systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Aug 30 19:56:00 volumio-socrates systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Aug 30 19:56:00 volumio-socrates sudo[10281]: pam_unix(sudo:session): session closed for user root Aug 30 19:56:00 volumio-socrates volumio[942]: info: Shairport-Sync Started Aug 30 19:56:01 volumio-socrates volumio[942]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Aug 30 19:56:01 volumio-socrates volumio[942]: info: camilladsp service started and running in background, instance 1 Aug 30 19:56:01 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Aug 30 19:56:01 volumio-socrates volumio[942]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 19:56:01 volumio-socrates volumio[942]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Aug 30 19:56:01 volumio-socrates volumio[942]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Aug 30 19:56:01 volumio-socrates volumio[942]: info: FusionDsp loaded Aug 30 19:56:01 volumio-socrates volumio[942]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Aug 30 19:56:01 volumio-socrates sudo[10306]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Aug 30 19:56:01 volumio-socrates sudo[10306]: pam_unix(sudo:session): session opened for user root by (uid=0) Aug 30 19:56:01 volumio-socrates volumio[942]: info: FusionDsp - Reporting Fusion DSP Enabled Aug 30 19:56:01 volumio-socrates volumio[942]: info: Adding Signal Path Element [object Object] Aug 30 19:56:01 volumio-socrates volumio[942]: info: Adding fusiondspeq DSP Signal Path Element Aug 30 19:56:01 volumio-socrates volumio[942]: info: FusionDsp - ---- installed callbackRead Aug 30 19:56:01 volumio-socrates volumio[942]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 19:56:01 volumio-socrates volumio[942]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Aug 30 19:56:01 volumio-socrates volumio[942]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Aug 30 19:56:01 volumio-socrates volumio[942]: at onErrorNT (internal/child_process.js:465:16) Aug 30 19:56:01 volumio-socrates volumio[942]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Aug 30 19:56:01 volumio-socrates volumio[942]: errno: -2, Aug 30 19:56:01 volumio-socrates volumio[942]: code: 'ENOENT', Aug 30 19:56:01 volumio-socrates volumio[942]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 19:56:01 volumio-socrates volumio[942]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Aug 30 19:56:01 volumio-socrates volumio[942]: spawnargs: [ Aug 30 19:56:01 volumio-socrates volumio[942]: '-p', Aug 30 19:56:01 volumio-socrates volumio[942]: 9876, Aug 30 19:56:01 volumio-socrates volumio[942]: '-o', Aug 30 19:56:01 volumio-socrates volumio[942]: '/tmp/camilladsp.log', Aug 30 19:56:01 volumio-socrates volumio[942]: '-l', Aug 30 19:56:01 volumio-socrates volumio[942]: 'warn', Aug 30 19:56:01 volumio-socrates volumio[942]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Aug 30 19:56:01 volumio-socrates volumio[942]: ] Aug 30 19:56:01 volumio-socrates volumio[942]: } Aug 30 19:56:01 volumio-socrates volumio[942]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Aug 30 19:56:01 volumio-socrates systemd[1]: Started FusionDsp Daemon. Aug 30 19:56:01 volumio-socrates sudo[10306]: pam_unix(sudo:session): session closed for user root Aug 30 19:56:01 volumio-socrates mpd[10275]: Aug 30 19:56 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Aug 30 19:56:01 volumio-socrates sudo[10235]: pam_unix(sudo:session): session closed for user root Aug 30 19:56:01 volumio-socrates systemd[1]: Started Music Player Daemon. Aug 30 19:56:01 volumio-socrates sudo[10264]: pam_unix(sudo:session): session closed for user root Aug 30 19:56:01 volumio-socrates volumio[10308]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Aug 30 19:56:02 volumio-socrates systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Aug 30 19:56:02 volumio-socrates systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Aug 30 19:56:04 volumio-socrates systemd[1]: fusiondsp.service: Service RestartSec=2s expired, scheduling restart. Aug 30 19:56:04 volumio-socrates systemd[1]: fusiondsp.service: Scheduled restart job, restart counter is at 1. Aug 30 19:56:04 volumio-socrates systemd[1]: Stopped FusionDsp Daemon. Aug 30 19:56:04 volumio-socrates systemd[1]: Started FusionDsp Daemon. Aug 30 19:56:04 volumio-socrates volumio[10333]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Aug 30 19:56:04 volumio-socrates systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Aug 30 19:56:04 volumio-socrates systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Aug 30 19:56:04 volumio-socrates sudo[10341]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-08-30 19:55 Aug 30 19:56:04 volumio-socrates sudo[10341]: 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="5fd3886148e72a9cecd88a772d1f6079fb64d11a" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="8bb23b009e91ae4c7ecd678f193e7d3b281fca0c" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 22 Jul 2024 07:17:01 PM CEST" VOLUMIO_VERSION="3.742" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="2782e52360f70dfab079c82951ebbbb1"