-- Logs begin at Fri 2024-07-19 20:38:24 CEST, end at Sat 2024-07-20 09:49:33 CEST. -- Jul 20 09:48:00 volumio volumio[17210]: info: Fetched 469 kB in 5s (91.6 kB/s) Jul 20 09:48:05 volumio volumio[17210]: info: Reading package lists... Jul 20 09:48:14 volumio volumio[1080]: [Vollibrespot] : couldn't parse packet from V4(192.168.88.1:5353): type 47 is invalid Jul 20 09:48:15 volumio volumio[17210]: info: Building dependency tree... Jul 20 09:48:22 volumio sudo[7264]: pam_unix(sudo:session): session closed for user root Jul 20 09:48:22 volumio volumio[17210]: info: Enabling plugin fusiondsp Jul 20 09:48:22 volumio volumio[17210]: info: Loading plugin "fusiondsp"... Jul 20 09:48:22 volumio sudo[7513]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/apt -y install python3-aiohttp python3-pip Jul 20 09:48:22 volumio sudo[7513]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:27 volumio volumio[1080]: [Vollibrespot] : couldn't parse packet from V4(192.168.88.1:5353): type 47 is invalid Jul 20 09:48:29 volumio volumio-remote-updater[566]: [2024-07-20 09:48:29] [disconnect] Disconnect close local:[1008,Pong timeout] remote:[1006] Jul 20 09:48:34 volumio volumio-remote-updater[566]: [2024-07-20 09:48:34] [connect] Successful connection Jul 20 09:48:41 volumio volumio[1080]: [Vollibrespot] : couldn't parse packet from V4(192.168.88.1:26166): type 47 is invalid Jul 20 09:48:44 volumio volumio[17210]: info: Preparing to generate the ALSA configuration file Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::getUIConfigOnPlugin Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::volumioGetState Jul 20 09:48:44 volumio volumio[17210]: info: Reading state information... Jul 20 09:48:44 volumio volumio[17210]: info: 5 packages can be upgraded. Run 'apt list --upgradable' to see them. Jul 20 09:48:44 volumio volumio[17210]: info: Reading package lists... Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 1 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 2 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 3 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 4 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 5 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 6 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 7 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 8 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 9 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 10 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 11 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.86 UA: Mozilla/5.0 (X11; Linux x86_64) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/126.0.0.0 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 12 Jul 20 09:48:44 volumio volumio[17210]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: Mozilla/5.0 (X11; CrOS armv7l 13597.84.0) AppleWebKit/537.36 (KHTML, like Gecko) Chrome/92.0.4515.98 Safari/537.36 Engine version: 3 Transport: polling Total Clients: 13 Jul 20 09:48:44 volumio volumio[17210]: info: Asound.conf file unchanged, so no further update is needed Jul 20 09:48:44 volumio volumio[17210]: info: Output device has changed, restarting MPD Jul 20 09:48:44 volumio sudo[7520]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 20 09:48:44 volumio sudo[7520]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:44 volumio volumio[17210]: info: Output device has changed, restarting Shairport Sync Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:44 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 20 09:48:44 volumio sudo[7523]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 20 09:48:44 volumio sudo[7523]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:44 volumio systemd[1]: Stopping Music Player Daemon... Jul 20 09:48:45 volumio sudo[7520]: pam_unix(sudo:session): session closed for user root Jul 20 09:48:45 volumio volumio[17210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Relinquishing Volumio State Jul 20 09:48:45 volumio volumio[17210]: verbose: UNSET VOLATILE: Service: volspotconnect2 Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] unSetVolatile called Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Relinquishing Volumio State to another service Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Received stop Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Creating VLS config file Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] /tmp/volume: 81 Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:45 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Volumio alsa_controller configuration: Jul 20 09:48:45 volumio volumio[17210]: outdev:volumio Jul 20 09:48:45 volumio volumio[17210]: outputdevicemixer:1 Jul 20 09:48:45 volumio volumio[17210]: volcurve:logarithmic Jul 20 09:48:45 volumio volumio[17210]: mixtype:Hardware Jul 20 09:48:45 volumio volumio[17210]: mixname:Digital Jul 20 09:48:45 volumio volumio[17210]: Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] MODULAR_ALSA_PIPELINE: true Jul 20 09:48:45 volumio volumio[17210]: [SpotifyConnect] Jul 20 09:48:45 volumio volumio[17210]: outdev:volumio Jul 20 09:48:45 volumio volumio[17210]: mixer:alsa Jul 20 09:48:45 volumio volumio[17210]: mixname:Digital Jul 20 09:48:45 volumio volumio[17210]: mixdev:hw:1 Jul 20 09:48:45 volumio volumio[17210]: mixidx:0 Jul 20 09:48:45 volumio volumio[17210]: Jul 20 09:48:45 volumio volumio[17210]: info: CoreStateMachine::resetVolumioState Jul 20 09:48:45 volumio volumio[17210]: info: CoreStateMachine::getcurrentVolume Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioRetrievevolume Jul 20 09:48:46 volumio volumio[17210]: info: PLUGIN START: fusiondsp Jul 20 09:48:46 volumio volumio[17210]: info: Loading i18n strings for locale pl Jul 20 09:48:46 volumio volumio[17210]: error: touch_display: Fetching language file: Error: i18n file complementing the system language not found. Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: FusionDsp - mixtype--------------------- Hardware Jul 20 09:48:46 volumio volumio[17210]: info: Preparing to generate the ALSA configuration file Jul 20 09:48:46 volumio volumio[17210]: info: Done. Jul 20 09:48:46 volumio systemd[1]: mpd.service: Succeeded. Jul 20 09:48:46 volumio systemd[1]: Stopped Music Player Daemon. Jul 20 09:48:46 volumio volumio[17210]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jul 20 09:48:46 volumio volumio[17210]: info: Reading ALSA contributions from plugins. Jul 20 09:48:46 volumio systemd[1]: Starting Music Player Daemon... Jul 20 09:48:46 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: polling Total Clients: 14 Jul 20 09:48:46 volumio volumio[17210]: info: MPD Permissions set Jul 20 09:48:46 volumio sudo[7531]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 20 09:48:46 volumio sudo[7531]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:46 volumio sudo[7531]: pam_unix(sudo:session): session closed for user root Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Pause Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Event: Pause { track_id: SpotifyId { id: 289340812561000672718230927290262821257, audio_type: Track }, position_ms: 160697 } Jul 20 09:48:46 volumio volumio[17210]: verbose: New Socket.io Connection to 192.168.88.91 from 192.168.88.84 UA: okhttp/4.9.2 Engine version: 3 Transport: websocket Total Clients: 15 Jul 20 09:48:46 volumio volumio[17210]: info: Building dependency tree... Jul 20 09:48:46 volumio volumio[17210]: info: Reading state information... Jul 20 09:48:46 volumio volumio[17210]: info: The following additional packages will be installed: Jul 20 09:48:46 volumio volumio[17210]: info: build-essential bzip2 dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8 Jul 20 09:48:46 volumio volumio[17210]: info: libalgorithm-diff-perl libalgorithm-diff-xs-perl libalgorithm-merge-perl Jul 20 09:48:46 volumio volumio[17210]: info: libasan5 libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libpython3-dev Jul 20 09:48:46 volumio volumio[17210]: info: libpython3.7 libpython3.7-dev libstdc++-8-dev libubsan1 make patch Jul 20 09:48:46 volumio volumio[17210]: info: python-pip-whl python3-asn1crypto python3-async-timeout python3-attr Jul 20 09:48:46 volumio volumio[17210]: info: python3-cffi-backend python3-crypto python3-cryptography python3-dbus Jul 20 09:48:46 volumio volumio[17210]: info: python3-dev python3-entrypoints python3-gi python3-keyring Jul 20 09:48:46 volumio volumio[17210]: info: python3-keyrings.alt python3-multidict python3-secretstorage Jul 20 09:48:46 volumio volumio[17210]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev Jul 20 09:48:46 volumio volumio[17210]: info: Suggested packages: Jul 20 09:48:46 volumio volumio[17210]: info: bzip2-doc debian-keyring gcc-8-doc libstdc++6-8-dbg gcc-multilib autoconf Jul 20 09:48:46 volumio volumio[17210]: info: automake libtool flex bison gdb gcc-doc gcc-8-locales libgcc1-dbg Jul 20 09:48:46 volumio volumio[17210]: info: libgomp1-dbg libitm1-dbg libatomic1-dbg libasan5-dbg liblsan0-dbg Jul 20 09:48:46 volumio volumio[17210]: info: libtsan0-dbg libubsan1-dbg libmpx2-dbg libquadmath0-dbg libstdc++-8-doc Jul 20 09:48:46 volumio volumio[17210]: info: make-doc ed diffutils-doc python-attr-doc python-crypto-doc Jul 20 09:48:46 volumio volumio[17210]: info: python-cryptography-doc python3-cryptography-vectors python-dbus-doc Jul 20 09:48:46 volumio volumio[17210]: info: python3-dbus-dbg gnome-keyring libkf5wallet-bin gir1.2-gnomekeyring-1.0 Jul 20 09:48:46 volumio volumio[17210]: info: python-secretstorage-doc python-setuptools-doc Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Pause Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] pause Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Shape Of My Heart Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Not pushing metadata: { active: false, isStopping: true } Jul 20 09:48:46 volumio volumio[17210]: info: VolumeController:: Volume=81 Mute =false Jul 20 09:48:46 volumio volumio[17210]: info: CoreStateMachine::pushState Jul 20 09:48:46 volumio volumio[17210]: info: CorePlayQueue::getTrack 0 Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioPushState Jul 20 09:48:46 volumio volumio[17210]: info: CoreStateMachine::updateTrackBlock Jul 20 09:48:46 volumio volumio[17210]: info: CorePlayQueue::getTrackBlock Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioRetrievevolume Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:46 volumio volumio[17210]: info: The following NEW packages will be installed: Jul 20 09:48:46 volumio volumio[17210]: info: build-essential bzip2 dh-python dpkg-dev fakeroot g++ g++-8 gcc gcc-8 Jul 20 09:48:46 volumio volumio[17210]: info: libalgorithm-diff-perl libalgorithm-diff-xs-perl libalgorithm-merge-perl Jul 20 09:48:46 volumio volumio[17210]: info: libasan5 libcc1-0 libexpat1-dev libfakeroot libgcc-8-dev libpython3-dev Jul 20 09:48:46 volumio volumio[17210]: info: libpython3.7 libpython3.7-dev libstdc++-8-dev libubsan1 make patch Jul 20 09:48:46 volumio volumio[17210]: info: python-pip-whl python3-aiohttp python3-asn1crypto python3-async-timeout Jul 20 09:48:46 volumio volumio[17210]: info: python3-attr python3-cffi-backend python3-crypto python3-cryptography Jul 20 09:48:46 volumio volumio[17210]: info: python3-dbus python3-dev python3-entrypoints python3-gi python3-keyring Jul 20 09:48:46 volumio volumio[17210]: info: python3-keyrings.alt python3-multidict python3-pip python3-secretstorage Jul 20 09:48:46 volumio volumio[17210]: info: python3-setuptools python3-wheel python3-xdg python3-yarl python3.7-dev Jul 20 09:48:46 volumio volumio[17210]: info: Starting Shairport Sync Jul 20 09:48:46 volumio volumio[17210]: info: 0 upgraded, 46 newly installed, 0 to remove and 7 not upgraded. Jul 20 09:48:46 volumio volumio[17210]: info: Need to get 72.4 MB of archives. Jul 20 09:48:46 volumio volumio[17210]: info: After this operation, 160 MB of additional disk space will be used. Jul 20 09:48:46 volumio volumio[17210]: info: Get:1 http://archive.raspberrypi.org/debian buster/main armhf python-pip-whl all 18.1-5+rpt1 [1591 kB] Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Restarting Vollibrespot Daemon Jul 20 09:48:46 volumio volumio[17210]: info: VolumeController:: Volume=81 Mute =false Jul 20 09:48:46 volumio volumio[17210]: info: CoreStateMachine::pushState Jul 20 09:48:46 volumio volumio[17210]: info: CorePlayQueue::getTrack 0 Jul 20 09:48:46 volumio volumio[17210]: info: CoreCommandRouter::volumioPushState Jul 20 09:48:46 volumio volumio[17210]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 16 Jul 20 09:48:46 volumio volumio[17210]: info: Get:4 http://archive.raspberrypi.org/debian buster/main armhf python3-pip all 18.1-5+rpt1 [171 kB] Jul 20 09:48:46 volumio volumio[17210]: info: Get:2 http://ftp.icm.edu.pl/pub/Linux/distributions/raspbian/raspbian buster/main armhf bzip2 armhf 1.0.6-9.2~deb10u2 [46.3 kB] Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Event: SinkInactive Jul 20 09:48:46 volumio volumio[1080]: [Vollibrespot] : Event: PlaybackStopped { track_id: SpotifyId { id: 289340812561000672718230927290262821257, audio_type: Track } } Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Sink released Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Not pushing Pause { active: false, isStopping: true} Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] ResolvedStop in 909s 328.79ms Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] ResolvedStop in 0s 963.64ms Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Device palyback is inactive Jul 20 09:48:46 volumio volumio[17210]: [SpotifyConnect] Device is paused Jul 20 09:48:46 volumio volumio[17210]: info: Asound.conf file written Jul 20 09:48:47 volumio sudo[7546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jul 20 09:48:47 volumio sudo[7546]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:47 volumio sudo[7548]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart volspotconnect2.service Jul 20 09:48:47 volumio sudo[7548]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:47 volumio sudo[7550]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mv /home/volumio/.asoundrc /etc/asound.conf Jul 20 09:48:47 volumio sudo[7550]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:47 volumio systemd[1]: Stopping Volspotconnect2 Daemon... Jul 20 09:48:47 volumio systemd[1]: volspotconnect2.service: Main process exited, code=killed, status=15/TERM Jul 20 09:48:47 volumio systemd[1]: volspotconnect2.service: Succeeded. Jul 20 09:48:47 volumio systemd[1]: Stopped Volspotconnect2 Daemon. Jul 20 09:48:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jul 20 09:48:47 volumio systemd[1]: Started Volspotconnect2 Daemon. Jul 20 09:48:47 volumio sudo[7548]: pam_unix(sudo:session): session closed for user root Jul 20 09:48:47 volumio systemd[1]: shairport-sync.service: Succeeded. Jul 20 09:48:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jul 20 09:48:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jul 20 09:48:47 volumio sudo[7546]: pam_unix(sudo:session): session closed for user root Jul 20 09:48:47 volumio volumio-remote-updater[566]: [2024-07-20 09:48:47] [connect] Successful connection Jul 20 09:48:47 volumio sudo[7550]: pam_unix(sudo:session): session closed for user root Jul 20 09:48:49 volumio volumio[17210]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock PLL:0' : Device or resource busy Jul 20 09:48:49 volumio volumio[17210]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DSP:0' : Device or resource busy Jul 20 09:48:49 volumio volumio[17210]: /usr/sbin/alsactl: set_control:1461: Cannot write control '2:0:0:Max Overclock DAC:0' : Device or resource busy Jul 20 09:48:49 volumio volumio[17210]: info: Output device has changed, restarting MPD Jul 20 09:48:49 volumio sudo[7563]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jul 20 09:48:49 volumio sudo[7563]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:49 volumio sudo[7563]: pam_unix(sudo:session): session closed for user root Jul 20 09:48:49 volumio volumio[17210]: info: Output device has changed, restarting Shairport Sync Jul 20 09:48:49 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:49 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jul 20 09:48:49 volumio sudo[7566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jul 20 09:48:49 volumio sudo[7566]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:50 volumio volumio[17210]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] Creating VLS config file Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] /tmp/volume: 81 Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:50 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] Volumio alsa_controller configuration: Jul 20 09:48:50 volumio volumio[17210]: outdev:volumio Jul 20 09:48:50 volumio volumio[17210]: outputdevicemixer:1 Jul 20 09:48:50 volumio volumio[17210]: volcurve:logarithmic Jul 20 09:48:50 volumio volumio[17210]: mixtype:Hardware Jul 20 09:48:50 volumio volumio[17210]: mixname:Digital Jul 20 09:48:50 volumio volumio[17210]: Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] MODULAR_ALSA_PIPELINE: true Jul 20 09:48:50 volumio volumio[17210]: [SpotifyConnect] Jul 20 09:48:50 volumio volumio[17210]: outdev:volumio Jul 20 09:48:50 volumio volumio[17210]: mixer:alsa Jul 20 09:48:50 volumio volumio[17210]: mixname:Digital Jul 20 09:48:50 volumio volumio[17210]: mixdev:hw:1 Jul 20 09:48:50 volumio volumio[17210]: mixidx:0 Jul 20 09:48:50 volumio volumio[17210]: Jul 20 09:48:55 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jul 20 09:48:55 volumio systemd[1]: mpd.service: Succeeded. Jul 20 09:48:55 volumio systemd[1]: Stopped Music Player Daemon. Jul 20 09:48:55 volumio systemd[1]: Starting Music Player Daemon... Jul 20 09:48:55 volumio sudo[7574]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jul 20 09:48:55 volumio sudo[7574]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:48:55 volumio sudo[7574]: pam_unix(sudo:session): session closed for user root Jul 20 09:49:02 volumio volumio-remote-updater[566]: [2024-07-20 09:49:02] [connect] Successful connection Jul 20 09:49:09 volumio volumio[7554]: vollibrespot v0.2.2 cd96399 2020-10-07 (librespot 08d8bcc 2020-10-07) -- Built On 2020-10-07 Jul 20 09:49:09 volumio volumio[7554]: Reading Config from "volspotify.toml" Jul 20 09:49:12 volumio mpd[7579]: Jul 20 09:49 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jul 20 09:49:15 volumio volumio[7554]: [Vollibrespot] : Using Alsa backend with device: volumio Jul 20 09:49:17 volumio volumio-remote-updater[566]: [2024-07-20 09:49:17] [connect] Successful connection Jul 20 09:49:21 volumio systemd[1]: Started Music Player Daemon. Jul 20 09:49:21 volumio sudo[7523]: pam_unix(sudo:session): session closed for user root Jul 20 09:49:21 volumio sudo[7566]: pam_unix(sudo:session): session closed for user root Jul 20 09:49:28 volumio volumio[7554]: [Vollibrespot] : Failed to register IPv6 receiver: Os { code: 19, kind: Other, message: "No such device" } Jul 20 09:49:28 volumio volumio[17210]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jul 20 09:49:28 volumio volumio[17210]: info: camilladsp service started and running in background, instance 1 Jul 20 09:49:28 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jul 20 09:49:29 volumio volumio[17210]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 20 09:49:29 volumio volumio[17210]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jul 20 09:49:29 volumio volumio[17210]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jul 20 09:49:29 volumio volumio[17210]: info: FusionDsp loaded Jul 20 09:49:29 volumio volumio[17210]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jul 20 09:49:29 volumio sudo[7632]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jul 20 09:49:29 volumio sudo[7632]: pam_unix(sudo:session): session opened for user root by (uid=0) Jul 20 09:49:29 volumio volumio[17210]: info: FusionDsp - Reporting Fusion DSP Enabled Jul 20 09:49:29 volumio volumio[17210]: info: Adding Signal Path Element [object Object] Jul 20 09:49:29 volumio volumio[17210]: info: Adding fusiondspeq DSP Signal Path Element Jul 20 09:49:29 volumio volumio[17210]: info: FusionDsp - ---- installed callbackRead Jul 20 09:49:29 volumio volumio[17210]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 20 09:49:29 volumio volumio[17210]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jul 20 09:49:29 volumio volumio[17210]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Jul 20 09:49:29 volumio volumio[17210]: at onErrorNT (internal/child_process.js:465:16) Jul 20 09:49:29 volumio volumio[17210]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Jul 20 09:49:29 volumio volumio[17210]: at runNextTicks (internal/process/task_queues.js:62:3) Jul 20 09:49:29 volumio volumio[17210]: at listOnTimeout (internal/timers.js:523:9) Jul 20 09:49:29 volumio volumio[17210]: at processTimers (internal/timers.js:497:7) { Jul 20 09:49:29 volumio volumio[17210]: errno: -2, Jul 20 09:49:29 volumio volumio[17210]: code: 'ENOENT', Jul 20 09:49:29 volumio volumio[17210]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jul 20 09:49:29 volumio volumio[17210]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jul 20 09:49:29 volumio volumio[17210]: spawnargs: [ Jul 20 09:49:29 volumio volumio[17210]: '-p', Jul 20 09:49:29 volumio volumio[17210]: 9876, Jul 20 09:49:29 volumio volumio[17210]: '-o', Jul 20 09:49:29 volumio volumio[17210]: '/tmp/camilladsp.log', Jul 20 09:49:29 volumio volumio[17210]: '-l', Jul 20 09:49:29 volumio volumio[17210]: 'warn', Jul 20 09:49:29 volumio volumio[17210]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jul 20 09:49:29 volumio volumio[17210]: ] Jul 20 09:49:29 volumio volumio[17210]: } Jul 20 09:49:29 volumio volumio[17210]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jul 20 09:49:32 volumio volumio-remote-updater[566]: [2024-07-20 09:49:32] [connect] Successful connection Jul 20 09:49:32 volumio sudo[7632]: pam_unix(sudo:session): session closed for user root Jul 20 09:49:33 volumio sudo[7646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2024-07-20 09:48 Jul 20 09:49:33 volumio sudo[7646]: 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="905ee02fb5387537cfa16b84ebd7f14b7640848e" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu 18 Jul 2024 07:14:40 PM CEST" VOLUMIO_VERSION="3.741" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="a68099d1a5f4301106a28f85f8548ae3"