-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Wed 2025-12-17 15:34:59 CET. -- Dec 17 15:34:50 volumio systemd-timedated[952]: Changed local time to Wed Dec 17 15:34:50 2025 Dec 17 15:34:50 volumio sudo[950]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:50 volumio volumio-time-update[619]: volumio-time-update-util: System time updated successfully. Dec 17 15:34:50 volumio systemd[1]: Starting Daily apt download activities... Dec 17 15:34:50 volumio systemd[1]: Started Volumio Time Update Utility. Dec 17 15:34:50 volumio systemd[1]: Reached target Multi-User System. Dec 17 15:34:50 volumio systemd[1]: Reached target Graphical Interface. Dec 17 15:34:50 volumio volumio[849]: info: Starting Udev Watcher for removable devices Dec 17 15:34:50 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes... Dec 17 15:34:50 volumio sudo[981]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=termit,password=mustang,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.40/Music /mnt/NAS/Music Dec 17 15:34:50 volumio sudo[981]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:50 volumio volumio[849]: info: Ignoring mount for partition: boot Dec 17 15:34:50 volumio volumio[849]: info: Ignoring mount for partition: volumio Dec 17 15:34:50 volumio volumio[849]: info: Ignoring mount for partition: volumio_data Dec 17 15:34:50 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 17 15:34:50 volumio volumio[849]: info: Loading plugin "volumio_command_line_client"... Dec 17 15:34:50 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. Dec 17 15:34:50 volumio systemd[1]: Started Update UTMP about System Runlevel Changes. Dec 17 15:34:50 volumio volumio[849]: info: Loading plugin "upnp"... Dec 17 15:34:50 volumio volumio[849]: info: [1765982090169] Starting Upmpd Daemon Dec 17 15:34:50 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 17 15:34:50 volumio volumio[849]: info: Loading plugin "my_music"... Dec 17 15:34:50 volumio volumio[849]: info: Loading plugin "mpd"... Dec 17 15:34:50 volumio kernel: Key type cifs.spnego registered Dec 17 15:34:50 volumio kernel: Key type cifs.idmap registered Dec 17 15:34:50 volumio kernel: CIFS: No dialect specified on mount. Default has changed to a more secure dialect, SMB2.1 or later (e.g. SMB3.1.1), from CIFS (SMB1). To use the less secure SMB1 dialect to access old servers which do not support SMB3.1.1 (or even SMB3 or SMB2.1) specify vers=1.0 on mount. Dec 17 15:34:50 volumio kernel: CIFS: Attempting to mount //192.168.0.40/Music Dec 17 15:34:50 volumio sudo[981]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:50 volumio volumio[849]: info: Loading plugin "upnp_browser"... Dec 17 15:34:51 volumio volumio-remote-updater[615]: [2025-12-17 15:34:51] [connect] Successful connection Dec 17 15:34:51 volumio volumio[849]: info: Loading plugin "alarm-clock"... Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "airplay_emulation"... Dec 17 15:34:52 volumio volumio[849]: info: Starting Shairport Sync Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "last_100"... Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "webradio"... Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "i2s_dacs"... Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "volumiodiscovery"... Dec 17 15:34:52 volumio volumio[849]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 17 15:34:52 volumio volumio[849]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 17 15:34:52 volumio volumio[849]: *** WARNING *** For more information see Dec 17 15:34:52 volumio node[849]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Dec 17 15:34:52 volumio volumio[849]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 17 15:34:52 volumio volumio[849]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 17 15:34:52 volumio volumio[849]: *** WARNING *** For more information see Dec 17 15:34:52 volumio node[849]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 17 15:34:52 volumio node[849]: *** WARNING *** For more information see Dec 17 15:34:52 volumio node[849]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Dec 17 15:34:52 volumio node[849]: *** WARNING *** Please fix your application to use the native API of Avahi! Dec 17 15:34:52 volumio node[849]: *** WARNING *** For more information see Dec 17 15:34:52 volumio volumio[849]: info: Applying required configuration parameters for plugin volumiodiscovery Dec 17 15:34:52 volumio volumio[849]: info: Discovery: Started advertising with name: Volumio Dec 17 15:34:52 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "outputs"... Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "albumart"... Dec 17 15:34:52 volumio volumio[849]: info: Plugin example_plugin is not enabled Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "inputs"... Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "updater_comm"... Dec 17 15:34:52 volumio volumio[849]: info: Plugin mpdemulation is not enabled Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "rest_api"... Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "websocket"... Dec 17 15:34:52 volumio volumio[849]: info: Starting Socket.io Server version 2.3.0 Dec 17 15:34:52 volumio volumio[849]: info: Loading plugin "fusiondsp"... Dec 17 15:34:52 volumio volumio[849]: Forking 3 albumart workers Dec 17 15:34:53 volumio volumio[849]: info: Applying required configuration parameters for plugin fusiondsp Dec 17 15:34:53 volumio volumio[849]: info: Loading plugin "radio_paradise"... Dec 17 15:34:54 volumio systemd[1]: apt-daily.service: Succeeded. Dec 17 15:34:54 volumio systemd[1]: Started Daily apt download activities. Dec 17 15:34:54 volumio systemd[1]: Starting Daily apt upgrade and clean activities... Dec 17 15:34:54 volumio volumio[849]: info: Applying required configuration parameters for plugin radio_paradise Dec 17 15:34:54 volumio volumio[849]: info: [1765982094256] [RadioParadise] API delay: 5 Dec 17 15:34:54 volumio volumio[849]: info: Loading plugin "ir_controller"... Dec 17 15:34:54 volumio volumio[849]: Starting albumart workers Dec 17 15:34:54 volumio volumio[849]: info: Applying required configuration parameters for plugin ir_controller Dec 17 15:34:54 volumio volumio[849]: Starting albumart workers Dec 17 15:34:54 volumio volumio[849]: Starting albumart workers Dec 17 15:34:54 volumio volumio[849]: info: Loading i18n strings for locale fr Dec 17 15:34:54 volumio volumio[849]: Updating browse sources language Dec 17 15:34:54 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::initPlayerControls Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 17 15:34:55 volumio volumio[849]: Express server listening on port 3000 Dec 17 15:34:55 volumio volumio[849]: [Metrics] WebUI: 9s 695.39ms Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::resetVolumioState Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::getcurrentVolume Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::volumioRetrievevolume Dec 17 15:34:55 volumio volumio[849]: info: Volumio Network Manager: Network status updated: 1 Dec 17 15:34:55 volumio volumio-remote-updater[615]: [2025-12-17 15:34:55] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1765982091 101 Dec 17 15:34:55 volumio volumio[849]: verbose: New Socket.io Connection to 127.0.0.1:3000 from 127.0.0.1 UA: WebSocket++/0.8.2 Engine version: 4 Transport: websocket Total Clients: 1 Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: Reloading queue from file Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::setRepeat null single undefined Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::pushState Dec 17 15:34:55 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::setRandom null Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::pushState Dec 17 15:34:55 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Dec 17 15:34:55 volumio volumio[849]: info: VolumeController:: Volume=19 Mute =false Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::pushState Dec 17 15:34:55 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Dec 17 15:34:55 volumio volumio[849]: info: CoreStateMachine::updateTrackBlock Dec 17 15:34:55 volumio volumio[849]: info: CorePlayQueue::getTrackBlock Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::volumioRetrievevolume Dec 17 15:34:55 volumio volumio[849]: info: Setting Device type: Raspberry PI Dec 17 15:34:55 volumio volumio[849]: info: Completed loading Core Plugins Dec 17 15:34:55 volumio volumio[849]: info: Preparing to generate the ALSA configuration file Dec 17 15:34:55 volumio volumio[849]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Dec 17 15:34:55 volumio volumio[849]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a22082 Dec 17 15:34:55 volumio volumio[849]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Dec 17 15:34:55 volumio volumio[849]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 17 15:34:55 volumio volumio[849]: info: Reading ALSA contributions from plugins. Dec 17 15:34:55 volumio volumio[849]: info: Asound.conf file unchanged, so no further update is needed Dec 17 15:34:55 volumio volumio[849]: info: Output device has changed, restarting MPD Dec 17 15:34:55 volumio volumio[849]: info: Output device has changed, restarting Shairport Sync Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:55 volumio sudo[1152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 15:34:55 volumio sudo[1152]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:55 volumio sudo[1152]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:55 volumio sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 15:34:55 volumio sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:55 volumio volumio[849]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 15:34:55 volumio volumio[849]: info: ___________ START PLUGINS ___________ Dec 17 15:34:55 volumio volumio[849]: info: ControllerMpd::onStart: Initializing MPD Dec 17 15:34:55 volumio volumio[849]: info: Creating MPD Configuration file Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 17 15:34:55 volumio volumio[849]: info: [1765982095909] CoreMusicLibrary::Adding element Serveurs Média Dec 17 15:34:55 volumio sudo[1162]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 15:34:55 volumio sudo[1162]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 15:34:55 volumio systemd[1]: Listening on mpd.socket. Dec 17 15:34:55 volumio sudo[1162]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:55 volumio systemd[1]: Starting Music Player Daemon... Dec 17 15:34:55 volumio sudo[1164]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 15:34:55 volumio sudo[1164]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:55 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:56 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Dec 17 15:34:56 volumio systemd[1]: mpd.service: Succeeded. Dec 17 15:34:56 volumio systemd[1]: Stopped Music Player Daemon. Dec 17 15:34:56 volumio systemd[1]: Starting Music Player Daemon... Dec 17 15:34:56 volumio volumio[849]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 17 15:34:56 volumio volumio[849]: info: [1765982096092] CoreMusicLibrary::Adding element Last_100 Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 17 15:34:56 volumio volumio[849]: info: [1765982096106] CoreMusicLibrary::Adding element Webradio Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 17 15:34:56 volumio volumio[849]: info: Initializing BBC Radios Dec 17 15:34:56 volumio sudo[1173]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 17 15:34:56 volumio sudo[1173]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:56 volumio sudo[1173]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 17 15:34:56 volumio sudo[1173]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: Loading i18n strings for locale fr Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: FusionDsp - mixtype--------------------- Hardware Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Dec 17 15:34:56 volumio volumio[849]: info: [1765982096231] CoreMusicLibrary::Adding element Radio Paradise Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Dec 17 15:34:56 volumio volumio[849]: Cannot find translation for source Radio Paradise Dec 17 15:34:56 volumio volumio[849]: info: Loading i18n strings for locale fr Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Dec 17 15:34:56 volumio volumio[849]: info: Volumio Calling Home Dec 17 15:34:56 volumio volumio[849]: info: Preparing to generate the ALSA configuration file Dec 17 15:34:56 volumio systemd[1]: apt-daily-upgrade.service: Succeeded. Dec 17 15:34:56 volumio systemd[1]: Started Daily apt upgrade and clean activities. Dec 17 15:34:56 volumio sudo[1222]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod -R a+rwX /etc/lirc/irexec.lircrc /etc/lirc/lirc_options.conf /etc/lirc/lircd.conf /etc/lirc/lircd.conf.d /etc/lirc/lircmd.conf /etc/lirc/lircrc Dec 17 15:34:56 volumio sudo[1222]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:56 volumio sudo[1222]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:56 volumio volumio[849]: info: Discovery: adding 201a64e9-27e8-4b2c-93e9-fc39e66a0667 Dec 17 15:34:56 volumio volumio[849]: info: Discovery: Found device Volumio Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Dec 17 15:34:56 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Dec 17 15:34:56 volumio volumio[849]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Dec 17 15:34:56 volumio volumio[849]: info: Reading ALSA contributions from plugins. Dec 17 15:34:56 volumio volumio[849]: info: ir_controller: File permissions successfully set on /etc/lirc/*. Dec 17 15:34:56 volumio volumio[849]: info: MPD Permissions set Dec 17 15:34:56 volumio volumio[849]: info: MPD Permissions set Dec 17 15:34:56 volumio volumio[849]: info: VolumeController:: Volume=19 Mute =false Dec 17 15:34:56 volumio volumio[849]: info: CoreStateMachine::pushState Dec 17 15:34:56 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::volumioPushState Dec 17 15:34:56 volumio volumio[849]: info: Volumio called home Dec 17 15:34:56 volumio volumio[849]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:56 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:57 volumio volumio[849]: info: Starting Shairport Sync Dec 17 15:34:57 volumio volumio[849]: info: Starting Shairport Sync Dec 17 15:34:57 volumio volumio[849]: info: Starting Shairport Sync Dec 17 15:34:57 volumio sudo[1233]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 15:34:57 volumio sudo[1233]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 15:34:57 volumio sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio volumio[849]: info: CoreCommandRouter::volumioGetState Dec 17 15:34:57 volumio volumio[849]: info: CorePlayQueue::getTrack 0 Dec 17 15:34:57 volumio sudo[1237]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 15:34:57 volumio sudo[1237]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 17 15:34:57 volumio volumio[849]: info: ir_controller: LIRC correctly updated. Dec 17 15:34:57 volumio volumio[849]: info: ir_controller: HAT did not load /proc/device-tree/ir_receiver! Dec 17 15:34:57 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 17 15:34:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 17 15:34:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 17 15:34:57 volumio sudo[1235]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio sudo[1237]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio sudo[1233]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio volumio[849]: info: Asound.conf file unchanged, so no further update is needed Dec 17 15:34:57 volumio volumio[849]: info: Output device has changed, restarting MPD Dec 17 15:34:57 volumio volumio[849]: info: Output device has changed, restarting Shairport Sync Dec 17 15:34:57 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:57 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:57 volumio sudo[1247]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Dec 17 15:34:57 volumio sudo[1247]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio sudo[1247]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Dec 17 15:34:57 volumio sudo[1249]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Dec 17 15:34:57 volumio systemd[1]: mpd.service: Succeeded. Dec 17 15:34:57 volumio systemd[1]: Stopped Music Player Daemon. Dec 17 15:34:57 volumio volumio[849]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Dec 17 15:34:57 volumio volumio[849]: info: ir_controller: Raspberry Pi revision code: a22082 Dec 17 15:34:57 volumio volumio[849]: info: Shairport-Sync Started Dec 17 15:34:57 volumio volumio[849]: Error adding Membership: Error: addMembership EINVAL Dec 17 15:34:57 volumio volumio[849]: info: Shairport-Sync Started Dec 17 15:34:57 volumio volumio[849]: info: Shairport-Sync Started Dec 17 15:34:57 volumio volumio[849]: info: MPD Permissions set Dec 17 15:34:57 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:57 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:57 volumio systemd[1]: Starting Music Player Daemon... Dec 17 15:34:57 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Dec 17 15:34:57 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:57 volumio volumio[849]: info: Starting Shairport Sync Dec 17 15:34:57 volumio sudo[1264]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -r -1 Dec 17 15:34:57 volumio sudo[1264]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio sudo[1264]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio sudo[1266]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Dec 17 15:34:57 volumio sudo[1266]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Dec 17 15:34:57 volumio systemd[1]: shairport-sync.service: Succeeded. Dec 17 15:34:57 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Dec 17 15:34:57 volumio sudo[1255]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Dec 17 15:34:57 volumio sudo[1255]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio sudo[1255]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Dec 17 15:34:57 volumio sudo[1255]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio sudo[1276]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-ir gpio_pin=25 gpio_pull=up Dec 17 15:34:57 volumio sudo[1276]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Dec 17 15:34:57 volumio kernel: Registered IR keymap rc-rc6-mce Dec 17 15:34:57 volumio sudo[1266]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio sudo[1276]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:57 volumio kernel: IR RC6 protocol handler initialized Dec 17 15:34:57 volumio volumio[849]: info: Shairport-Sync Started Dec 17 15:34:57 volumio volumio[849]: info: ir_controller: Overlay gpio-ir gpio_pin=25 gpio_pull=up loaded. Dec 17 15:34:57 volumio kernel: rc rc0: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0 Dec 17 15:34:57 volumio kernel: rc rc0: lirc_dev: driver gpio_ir_recv registered at minor = 0, raw IR receiver, no transmitter Dec 17 15:34:57 volumio kernel: input: gpio_ir_recv as /devices/platform/ir-receiver@19/rc/rc0/input0 Dec 17 15:34:57 volumio sudo[1291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart lircd.service Dec 17 15:34:57 volumio sudo[1291]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:57 volumio systemd[1]: Starting lircd(8) initialization helper tool... Dec 17 15:34:58 volumio systemd-udevd[1294]: Process '/usr/sbin/th-cmd --socket /var/run/thd.socket --passfd --udev' failed with exit code 1. Dec 17 15:34:58 volumio systemd-logind[621]: Watching system buttons on /dev/input/event0 (gpio_ir_recv) Dec 17 15:34:58 volumio volumio[849]: info: camilladsp service started and running in background, instance 1 Dec 17 15:34:58 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Dec 17 15:34:58 volumio volumio[849]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Dec 17 15:34:58 volumio volumio[849]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Dec 17 15:34:58 volumio volumio[849]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Dec 17 15:34:58 volumio volumio[849]: info: FusionDsp loaded Dec 17 15:34:58 volumio volumio[849]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Dec 17 15:34:58 volumio sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Dec 17 15:34:58 volumio sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0) Dec 17 15:34:58 volumio volumio[849]: info: FusionDsp - Reporting Fusion DSP Enabled Dec 17 15:34:58 volumio volumio[849]: info: Adding Signal Path Element [object Object] Dec 17 15:34:58 volumio volumio[849]: info: Adding fusiondspeq DSP Signal Path Element Dec 17 15:34:58 volumio volumio[849]: info: FusionDsp - ---- installed callbackRead Dec 17 15:34:58 volumio volumio[849]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 15:34:58 volumio volumio[849]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Dec 17 15:34:58 volumio volumio[849]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Dec 17 15:34:58 volumio volumio[849]: at onErrorNT (internal/child_process.js:465:16) Dec 17 15:34:58 volumio volumio[849]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Dec 17 15:34:58 volumio volumio[849]: errno: -2, Dec 17 15:34:58 volumio volumio[849]: code: 'ENOENT', Dec 17 15:34:58 volumio volumio[849]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Dec 17 15:34:58 volumio volumio[849]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Dec 17 15:34:58 volumio volumio[849]: spawnargs: [ Dec 17 15:34:58 volumio volumio[849]: '-p', Dec 17 15:34:58 volumio volumio[849]: 9876, Dec 17 15:34:58 volumio volumio[849]: '-o', Dec 17 15:34:58 volumio volumio[849]: '/tmp/camilladsp.log', Dec 17 15:34:58 volumio volumio[849]: '-l', Dec 17 15:34:58 volumio volumio[849]: 'warn', Dec 17 15:34:58 volumio volumio[849]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Dec 17 15:34:58 volumio volumio[849]: ] Dec 17 15:34:58 volumio volumio[849]: } Dec 17 15:34:58 volumio volumio[849]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Dec 17 15:34:58 volumio systemd[1]: Started FusionDsp Daemon. Dec 17 15:34:58 volumio sudo[1309]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:58 volumio lircd-setup[1297]: /usr/sbin/lircd-setup:37: DeprecationWarning: The SafeConfigParser class has been renamed to ConfigParser in Python 3.2. This alias will be removed in future versions. Use ConfigParser directly instead. Dec 17 15:34:58 volumio lircd-setup[1297]: parser = configparser.SafeConfigParser() Dec 17 15:34:58 volumio systemd[1]: lircd-setup.service: Succeeded. Dec 17 15:34:58 volumio systemd[1]: Started lircd(8) initialization helper tool. Dec 17 15:34:58 volumio systemd[1]: Starting Flexible IR remote input/output application support... Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Info: lircd: Opening log, level: Info Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Version: lircd 0.10.1 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: System info: Linux volumio 6.6.62-v7+ #1816 SMP Mon Nov 18 15:30:49 GMT 2024 armv7l GNU/Linux Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Info: Initial device: /dev/lirc0 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: 'lirc' written to protocols file /sys/class/rc/rc0/protocols Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Info: Initial device: /dev/lirc0 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Info: [lirc] protocol is enabled Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: driver: default Dec 17 15:34:58 volumio lircd[1320]: lircd-0.10.1[1320]: Info: lircd: Opening log, level: Info Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: output: /var/run/lirc/lircd Dec 17 15:34:58 volumio lircd[1320]: lircd-0.10.1[1320]: Notice: Using systemd fd Dec 17 15:34:58 volumio lircd[1320]: lircd-0.10.1[1320]: Warning: Running as root Dec 17 15:34:58 volumio lircd[1320]: lircd-0.10.1[1320]: Info: Using remote: lircd.conf. Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: nodaemon: 1 Dec 17 15:34:58 volumio lircd[1320]: lircd-0.10.1[1320]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: plugindir: /usr/lib/arm-linux-gnueabihf/lirc/plugins Dec 17 15:34:58 volumio systemd[1]: Started Flexible IR remote input/output application support. Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: logfile: syslog Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: immediate-init: 0 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: permission: 666 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: driver-options: Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: pidfile: /var/run/lirc/lircd.pid Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: listen: 0 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: connect: (null) Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: userelease: 0 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: effective_user: (null) Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: release_suffix: _EVUP Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: allow_simulate: 0 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: repeat_max: 600 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: configfile: /etc/lirc/lircd.conf Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Options: dynamic_codes: (null) Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Current driver: default Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Driver API version: 3 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Driver version: 0.10.0 Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Driver info: See file:///usr/share/doc/lirc/plugindocs/default.html Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Info: lircd: Opening log, level: Info Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: Using systemd fd Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Warning: Running as root Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Info: Using remote: lircd.conf. Dec 17 15:34:58 volumio lircd-0.10.1[1320]: Notice: lircd(default) ready, using /var/run/lirc/lircd Dec 17 15:34:58 volumio sudo[1291]: pam_unix(sudo:session): session closed for user root Dec 17 15:34:59 volumio sudo[1324]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-12-17 15:33 Dec 17 15:34:59 volumio sudo[1324]: 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="cc50ad4a2058d01de272214eb33827883bd2b7d8" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="502750e5d54ecf269d25125b622bfabc030fb553" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Wed 12 Nov 2025 06:58:02 PM CET" VOLUMIO_VERSION="3.874" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="4ae6504ed6f22e44c01a6e93b16badbd"