-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Sat 2025-04-26 17:24:53 CEST. -- Apr 26 17:24:45 volumio systemd-timedated[1076]: Changed local time to Sat Apr 26 17:24:45 2025 Apr 26 17:24:45 volumio sudo[1073]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:45 volumio volumio-time-update[595]: volumio-time-update-util: System time updated successfully. Apr 26 17:24:45 volumio systemd[1]: Started Volumio Time Update Utility. Apr 26 17:24:45 volumio systemd[1]: Reached target Multi-User System. Apr 26 17:24:45 volumio systemd[1]: Reached target Graphical Interface. Apr 26 17:24:45 volumio volumio[860]: info: Plugin mpdemulation is not enabled Apr 26 17:24:45 volumio volumio[860]: info: Loading plugin "rest_api"... Apr 26 17:24:45 volumio volumio[860]: info: Loading plugin "websocket"... Apr 26 17:24:45 volumio volumio[860]: info: Starting Socket.io Server version 2.3.0 Apr 26 17:24:45 volumio volumio[860]: info: Loading plugin "fusiondsp"... Apr 26 17:24:45 volumio ntpd[994]: Soliciting pool server 167.235.69.67 Apr 26 17:24:45 volumio ntpd[994]: Soliciting pool server 144.76.76.107 Apr 26 17:24:45 volumio ntpd[994]: Soliciting pool server 5.75.181.179 Apr 26 17:24:45 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Apr 26 17:24:45 volumio volumio[860]: Forking 3 albumart workers Apr 26 17:24:45 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Apr 26 17:24:45 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Apr 26 17:24:45 volumio systemd[1]: Startup finished in 14.510s (kernel) + 23.278s (userspace) = 37.788s. Apr 26 17:24:45 volumio volumio[860]: info: Applying required configuration parameters for plugin fusiondsp Apr 26 17:24:45 volumio volumio[860]: info: Loading plugin "backup_restore"... Apr 26 17:24:46 volumio ntpd[994]: Soliciting pool server 144.76.59.37 Apr 26 17:24:46 volumio ntpd[994]: Soliciting pool server 188.34.198.106 Apr 26 17:24:46 volumio volumio[860]: Starting albumart workers Apr 26 17:24:46 volumio volumio[860]: Starting albumart workers Apr 26 17:24:46 volumio volumio[860]: Starting albumart workers Apr 26 17:24:46 volumio volumio[860]: info: Applying required configuration parameters for plugin backup_restore Apr 26 17:24:46 volumio volumio[860]: info: Plugin gpio_control is not enabled Apr 26 17:24:46 volumio volumio[860]: info: Plugin ir_controller is not enabled Apr 26 17:24:46 volumio volumio[860]: info: Loading plugin "touch_display"... Apr 26 17:24:47 volumio ntpd[994]: Soliciting pool server 136.243.177.133 Apr 26 17:24:47 volumio ntpd[994]: Soliciting pool server 2003:a:87f:c37c::6 Apr 26 17:24:47 volumio volumio[860]: info: Applying required configuration parameters for plugin touch_display Apr 26 17:24:47 volumio volumio[860]: info: Loading i18n strings for locale de Apr 26 17:24:47 volumio volumio[860]: Updating browse sources language Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::initPlayerControls Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 17:24:47 volumio volumio[860]: Express server listening on port 3000 Apr 26 17:24:47 volumio volumio[860]: [Metrics] WebUI: 11s 402.11ms Apr 26 17:24:47 volumio volumio[860]: info: CoreStateMachine::resetVolumioState Apr 26 17:24:47 volumio volumio[860]: info: CoreStateMachine::getcurrentVolume Apr 26 17:24:47 volumio volumio[860]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 17:24:47 volumio volumio[860]: info: Volumio Network Manager: Network status updated: 1 Apr 26 17:24:48 volumio volumio[860]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 Apr 26 17:24:48 volumio volumio[860]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: Executing start script for DAC IQaudIO DAC Plus Apr 26 17:24:48 volumio volumio[860]: info: Reloading queue from file Apr 26 17:24:48 volumio volumio[860]: info: VolumeController:: Volume=0 Mute =false Apr 26 17:24:48 volumio volumio[860]: info: CoreStateMachine::pushState Apr 26 17:24:48 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioPushState Apr 26 17:24:48 volumio volumio[860]: info: CoreStateMachine::updateTrackBlock Apr 26 17:24:48 volumio volumio[860]: info: CorePlayQueue::getTrackBlock Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioRetrievevolume Apr 26 17:24:48 volumio volumio[860]: info: CoreStateMachine::setRepeat null single undefined Apr 26 17:24:48 volumio volumio[860]: info: CoreStateMachine::pushState Apr 26 17:24:48 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioPushState Apr 26 17:24:48 volumio volumio[860]: info: CoreStateMachine::setRandom true Apr 26 17:24:48 volumio volumio[860]: info: CoreStateMachine::pushState Apr 26 17:24:48 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioPushState Apr 26 17:24:48 volumio volumio[860]: info: Setting Device type: Raspberry PI Apr 26 17:24:48 volumio volumio[860]: info: DAC script executed Apr 26 17:24:48 volumio volumio[860]: info: Completed loading Core Plugins Apr 26 17:24:48 volumio volumio[860]: info: Preparing to generate the ALSA configuration file Apr 26 17:24:48 volumio volumio[860]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 26 17:24:48 volumio volumio[860]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 26 17:24:48 volumio volumio[860]: info: Reading ALSA contributions from plugins. Apr 26 17:24:48 volumio volumio[860]: info: VolumeController:: Volume=0 Mute =false Apr 26 17:24:48 volumio volumio[860]: info: CoreStateMachine::pushState Apr 26 17:24:48 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioPushState Apr 26 17:24:48 volumio volumio[860]: info: Discovery: adding 5e7e6251-6647-426c-9c87-f1c8e5f448b2 Apr 26 17:24:48 volumio volumio[860]: info: Discovery: Found device Volumio Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioGetState Apr 26 17:24:48 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:48 volumio volumio[860]: info: Discovery: A device disappeared from network Apr 26 17:24:48 volumio volumio[860]: info: Discovery: Device volumio disappeared from network Apr 26 17:24:48 volumio volumio[860]: info: Asound.conf file unchanged, so no further update is needed Apr 26 17:24:48 volumio volumio[860]: info: Output device has changed, restarting MPD Apr 26 17:24:48 volumio volumio[860]: info: Output device has changed, restarting Shairport Sync Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:48 volumio sudo[1151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 26 17:24:48 volumio sudo[1151]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:48 volumio sudo[1151]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:48 volumio sudo[1153]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 17:24:48 volumio sudo[1153]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:48 volumio systemd[1]: Stopping Music Player Daemon... Apr 26 17:24:48 volumio volumio[860]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 17:24:48 volumio volumio[860]: info: ___________ START PLUGINS ___________ Apr 26 17:24:48 volumio volumio[860]: info: ControllerMpd::onStart: Initializing MPD Apr 26 17:24:48 volumio volumio[860]: info: Creating MPD Configuration file Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 26 17:24:48 volumio sudo[1160]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 26 17:24:48 volumio volumio[860]: info: [1745681088667] CoreMusicLibrary::Adding element Medienserver Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 17:24:48 volumio sudo[1160]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:48 volumio sudo[1160]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:48 volumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Apr 26 17:24:48 volumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 26 17:24:48 volumio volumio[860]: info: [1745681088805] CoreMusicLibrary::Adding element Last_100 Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Apr 26 17:24:48 volumio volumio[860]: info: [1745681088809] CoreMusicLibrary::Adding element Webradio Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 17:24:48 volumio volumio[860]: info: Initializing BBC Radios Apr 26 17:24:48 volumio systemd[1]: mpd.service: Succeeded. Apr 26 17:24:48 volumio systemd[1]: Stopped Music Player Daemon. Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 17:24:48 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:48 volumio volumio[860]: info: Loading i18n strings for locale de Apr 26 17:24:48 volumio systemd[1]: Starting Music Player Daemon... Apr 26 17:24:48 volumio volumio[860]: info: /tmp/myfifo created Apr 26 17:24:48 volumio volumio[860]: info: /tmp/myfifosa created Apr 26 17:24:48 volumio sudo[1187]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/modprobe snd-dummy index=7 pcm_substreams=1 fake_buffer=0 Apr 26 17:24:48 volumio sudo[1187]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:49 volumio sudo[1187]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:49 volumio volumio[860]: info: snd-dummy loaded Apr 26 17:24:49 volumio sudo[1174]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Apr 26 17:24:49 volumio sudo[1174]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:49 volumio sudo[1174]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Apr 26 17:24:49 volumio sudo[1174]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: airplay_emulation , startShairportSync Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:49 volumio volumio[860]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Apr 26 17:24:49 volumio volumio[860]: info: Loading i18n strings for locale de Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:49 volumio volumio[860]: info: FusionDsp - mixtype--------------------- Hardware Apr 26 17:24:49 volumio volumio[860]: info: Loading i18n strings for locale de Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Apr 26 17:24:49 volumio volumio[860]: info: Volumio Calling Home Apr 26 17:24:49 volumio volumio[860]: info: Preparing to generate the ALSA configuration file Apr 26 17:24:49 volumio sudo[1212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl stop getty@tty1.service Apr 26 17:24:49 volumio sudo[1214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl disable getty@tty1.service Apr 26 17:24:49 volumio sudo[1212]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:49 volumio sudo[1214]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:49 volumio sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl daemon-reload Apr 26 17:24:49 volumio sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:49 volumio systemd[1]: Reloading. Apr 26 17:24:49 volumio volumio[860]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Apr 26 17:24:49 volumio volumio[860]: info: The plugin peppy_screensaver has an ALSA contribution file Peppyalsa.postPeppyalsa.5.conf Apr 26 17:24:49 volumio volumio[860]: info: Reading ALSA contributions from plugins. Apr 26 17:24:49 volumio volumio[860]: error: touch_display: Error detecting backlight interface: Error: ENOENT: no such file or directory, scandir '/sys/class/backlight/' Apr 26 17:24:49 volumio volumio[860]: info: Discovery: adding 5e7e6251-6647-426c-9c87-f1c8e5f448b2 Apr 26 17:24:49 volumio volumio[860]: info: Discovery: Found device Volumio Apr 26 17:24:49 volumio volumio[860]: info: CoreCommandRouter::volumioGetState Apr 26 17:24:50 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::volumioGetState Apr 26 17:24:50 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:50 volumio volumio[860]: info: MPD Permissions set Apr 26 17:24:50 volumio volumio[860]: info: MPD Permissions set Apr 26 17:24:50 volumio 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. Apr 26 17:24:50 volumio volumio[860]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio sudo[1241]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount --bind /tmp/mpd.conf.tmpl /volumio/app/plugins/music_service/mpd/mpd.conf.tmpl Apr 26 17:24:50 volumio sudo[1241]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:50 volumio sudo[1241]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:50 volumio volumio[860]: info: Volumio called home Apr 26 17:24:50 volumio volumio[860]: info: touch_display: No Raspberry Pi Foundation touch screen detected. Apr 26 17:24:50 volumio sudo[1248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod a+rw /etc/X11/xorg.conf.d/99-vc4.conf Apr 26 17:24:50 volumio sudo[1248]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:50 volumio sudo[1248]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:50 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: mpd , createMPDFile Apr 26 17:24:50 volumio sudo[1216]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:50 volumio systemd[1]: Reloading. Apr 26 17:24:50 volumio sudo[1251]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Apr 26 17:24:50 volumio sudo[1251]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:51 volumio volumio[860]: info: touch_display: File permissions for /etc/X11/xorg.conf.d/99-vc4.conf set. Apr 26 17:24:51 volumio volumio[860]: info: Starting Shairport Sync Apr 26 17:24:51 volumio sudo[1251]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:51 volumio volumio[860]: info: Starting Shairport Sync Apr 26 17:24:51 volumio volumio[860]: info: Starting Shairport Sync Apr 26 17:24:51 volumio ntpd[994]: receive: Unexpected origin timestamp 0xebb77943.1d286398 does not match aorg 0000000000.00000000 from server@144.76.59.37 xmt 0xebb77943.c0d3d2f6 Apr 26 17:24:51 volumio ntpd[994]: receive: Unexpected origin timestamp 0xebb77943.1d3bc66d does not match aorg 0000000000.00000000 from server@176.9.44.212 xmt 0xebb77943.c06f22ec Apr 26 17:24:51 volumio ntpd[994]: receive: Unexpected origin timestamp 0xebb77943.1d41abf4 does not match aorg 0000000000.00000000 from server@148.251.5.46 xmt 0xebb77943.c08285cc Apr 26 17:24:51 volumio ntpd[994]: receive: Unexpected origin timestamp 0xebb77943.1d3eca13 does not match aorg 0000000000.00000000 from server@188.34.165.100 xmt 0xebb77943.c0fd87cd Apr 26 17:24:51 volumio ntpd[994]: receive: Unexpected origin timestamp 0xebb77943.1d2ea4f4 does not match aorg 0000000000.00000000 from server@129.70.132.37 xmt 0xebb77943.c0b548bd Apr 26 17:24:51 volumio ntpd[994]: receive: Unexpected origin timestamp 0xebb77943.1d3283a1 does not match aorg 0000000000.00000000 from server@93.241.86.156 xmt 0xebb77943.c19d7aa0 Apr 26 17:24:51 volumio volumio[860]: info: Starting Shairport Sync Apr 26 17:24:51 volumio sudo[1254]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 17:24:51 volumio sudo[1254]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:51 volumio sudo[1272]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 17:24:51 volumio sudo[1272]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:51 volumio sudo[1256]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 17:24:51 volumio sudo[1256]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:51 volumio mpd[1197]: Apr 26 17:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Apr 26 17:24:51 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Apr 26 17:24:52 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:52 volumio volumio[860]: info: CoreCommandRouter::volumioGetState Apr 26 17:24:52 volumio volumio[860]: info: CorePlayQueue::getTrack 0 Apr 26 17:24:52 volumio volumio[860]: info: touch_display: systemctl daemon-reload succeeded. Apr 26 17:24:52 volumio 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. Apr 26 17:24:52 volumio sudo[1296]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start volumio-kiosk.service Apr 26 17:24:52 volumio sudo[1296]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:52 volumio volumio[860]: info: camilladsp service started and running in background, instance 1 Apr 26 17:24:52 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Apr 26 17:24:52 volumio volumio[860]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 26 17:24:52 volumio volumio[860]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Apr 26 17:24:52 volumio volumio[860]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Apr 26 17:24:52 volumio volumio[860]: info: FusionDsp loaded Apr 26 17:24:52 volumio volumio[860]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Apr 26 17:24:52 volumio sudo[1308]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Apr 26 17:24:52 volumio sudo[1308]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:52 volumio volumio[860]: info: FusionDsp - Reporting Fusion DSP Enabled Apr 26 17:24:52 volumio volumio[860]: info: Adding Signal Path Element [object Object] Apr 26 17:24:52 volumio volumio[860]: info: Adding fusiondspeq DSP Signal Path Element Apr 26 17:24:52 volumio volumio[860]: info: FusionDsp - ---- installed callbackRead Apr 26 17:24:52 volumio volumio[860]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 17:24:52 volumio volumio[860]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Apr 26 17:24:52 volumio volumio[860]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Apr 26 17:24:52 volumio volumio[860]: at onErrorNT (internal/child_process.js:465:16) Apr 26 17:24:52 volumio volumio[860]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Apr 26 17:24:52 volumio volumio[860]: at runNextTicks (internal/process/task_queues.js:62:3) Apr 26 17:24:52 volumio volumio[860]: at listOnTimeout (internal/timers.js:523:9) Apr 26 17:24:52 volumio volumio[860]: at processTimers (internal/timers.js:497:7) { Apr 26 17:24:52 volumio volumio[860]: errno: -2, Apr 26 17:24:52 volumio volumio[860]: code: 'ENOENT', Apr 26 17:24:52 volumio volumio[860]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Apr 26 17:24:52 volumio volumio[860]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Apr 26 17:24:52 volumio volumio[860]: spawnargs: [ Apr 26 17:24:52 volumio volumio[860]: '-p', Apr 26 17:24:52 volumio volumio[860]: 9876, Apr 26 17:24:52 volumio volumio[860]: '-o', Apr 26 17:24:52 volumio volumio[860]: '/tmp/camilladsp.log', Apr 26 17:24:52 volumio volumio[860]: '-l', Apr 26 17:24:52 volumio volumio[860]: 'warn', Apr 26 17:24:52 volumio volumio[860]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Apr 26 17:24:52 volumio volumio[860]: ] Apr 26 17:24:52 volumio volumio[860]: } Apr 26 17:24:52 volumio volumio[860]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Apr 26 17:24:52 volumio systemd[1]: Started Music Player Daemon. Apr 26 17:24:52 volumio sudo[1214]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:52 volumio sudo[1153]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:52 volumio sudo[1162]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:53 volumio systemd[1]: Started FusionDsp Daemon. Apr 26 17:24:53 volumio systemd[1]: Started Volumio Kiosk. Apr 26 17:24:53 volumio sudo[1296]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:53 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Apr 26 17:24:53 volumio systemd[1]: shairport-sync.service: Succeeded. Apr 26 17:24:53 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Apr 26 17:24:53 volumio sudo[1308]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:53 volumio sudo[1212]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:53 volumio volumio[1318]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory Apr 26 17:24:53 volumio sudo[1329]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-26 17:23 Apr 26 17:24:53 volumio sudo[1329]: pam_unix(sudo:session): session opened for user root by (uid=0) Apr 26 17:24:53 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Apr 26 17:24:53 volumio sudo[1272]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:53 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT Apr 26 17:24:53 volumio sudo[1256]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:53 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'. Apr 26 17:24:53 volumio sudo[1254]: pam_unix(sudo:session): session closed for user root Apr 26 17:24:53 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root PRETTY_NAME="Raspbian GNU/Linux 10 (buster)" NAME="Raspbian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="147953990fca4aa103a8f90538ef56fb0454638c" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="e32c2c71ae78852844c70357816bdd871c155ab8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Mon 31 Mar 2025 06:54:47 PM CEST" VOLUMIO_VERSION="3.799" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="436f3f84f6d0b4ffc344f0bc132a32e8"