-- Logs begin at Thu 2019-02-14 11:11:59 CET, end at Thu 2025-04-24 06:53:57 CEST. --
Apr 24 06:53:20 volumio systemd-timedated[1016]: Changed local time to Thu Apr 24 06:53:20 2025
Apr 24 06:53:20 volumio sudo[1014]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:20 volumio volumio-time-update[629]: volumio-time-update-util: System time updated successfully.
Apr 24 06:53:20 volumio systemd[1]: Starting Daily apt download activities...
Apr 24 06:53:20 volumio systemd[1]: Started Volumio Time Update Utility.
Apr 24 06:53:20 volumio systemd[1]: Reached target Multi-User System.
Apr 24 06:53:20 volumio systemd[1]: Reached target Graphical Interface.
Apr 24 06:53:20 volumio systemd[1]: Starting Update UTMP about System Runlevel Changes...
Apr 24 06:53:20 volumio systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.
Apr 24 06:53:20 volumio systemd[1]: Started Update UTMP about System Runlevel Changes.
Apr 24 06:53:21 volumio volumio[976]: info: MYVOLUMIO Environment detected
Apr 24 06:53:21 volumio volumio-remote-updater[627]: [2025-04-24 06:53:21] [connect] Successful connection
Apr 24 06:53:22 volumio volumio[976]: info: Plugin folders cleanup
Apr 24 06:53:22 volumio volumio[976]: info: Scanning into folder /volumio/app/plugins/
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category audio_interface
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category miscellanea
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category music_service
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category plugins.json
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category system_controller
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category user_interface
Apr 24 06:53:22 volumio volumio[976]: info: Scanning into folder /data/plugins/
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category audio_interface
Apr 24 06:53:22 volumio volumio[976]: info: Scanning category music_service
Apr 24 06:53:22 volumio volumio[976]: info: Plugin folders cleanup completed
Apr 24 06:53:22 volumio volumio[976]: info: -------------------------------------------
Apr 24 06:53:22 volumio volumio[976]: info: ----- Core plugins startup ----
Apr 24 06:53:22 volumio volumio[976]: info: -------------------------------------------
Apr 24 06:53:22 volumio volumio[976]: info: Loading plugins from folder /volumio/app/plugins/
Apr 24 06:53:22 volumio volumio[976]: info: Adding plugin upnp to MyMusic Plugins
Apr 24 06:53:22 volumio volumio[976]: info: Adding plugin airplay_emulation to MyMusic Plugins
Apr 24 06:53:22 volumio volumio[976]: info: Adding plugin upnp_browser to MyMusic Plugins
Apr 24 06:53:22 volumio volumio[976]: info: Loading plugins from folder /data/plugins/
Apr 24 06:53:22 volumio volumio[976]: info: Loading plugin "system"...
Apr 24 06:53:22 volumio volumio[976]: info: Loading plugin "appearance"...
Apr 24 06:53:25 volumio volumio[976]: info: Loading plugin "network"...
Apr 24 06:53:25 volumio volumio[976]: info: Refreshing Cached IP Addresses
Apr 24 06:53:25 volumio sudo[1059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 24 06:53:25 volumio sudo[1059]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:25 volumio sudo[1059]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:25 volumio sudo[1061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 24 06:53:25 volumio sudo[1061]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:25 volumio volumio[976]: info: Loading plugin "services"...
Apr 24 06:53:25 volumio sudo[1061]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:25 volumio volumio[976]: info: Loading plugin "alsa_controller"...
Apr 24 06:53:25 volumio sudo[1066]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan
Apr 24 06:53:25 volumio sudo[1066]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:25 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 24 06:53:25 volumio volumio[976]: info: Loading plugin "wizard"...
Apr 24 06:53:26 volumio volumio[976]: info: Loading plugin "networkfs"...
Apr 24 06:53:26 volumio volumio[976]: info: Starting Udev Watcher for removable devices
Apr 24 06:53:26 volumio sudo[1087]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o guest,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.1.156/music /mnt/NAS/music
Apr 24 06:53:26 volumio sudo[1087]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:26 volumio volumio[976]: info: Ignoring mount for partition: boot
Apr 24 06:53:26 volumio volumio[976]: info: Ignoring mount for partition: volumio
Apr 24 06:53:26 volumio volumio[976]: info: Ignoring mount for partition: volumio_data
Apr 24 06:53:26 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 06:53:26 volumio volumio[976]: info: Loading plugin "volumio_command_line_client"...
Apr 24 06:53:26 volumio sudo[1066]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:26 volumio volumio[976]: info: Loading plugin "upnp"...
Apr 24 06:53:26 volumio systemd[1]: systemd-fsckd.service: Succeeded.
Apr 24 06:53:26 volumio volumio[976]: info: [1745470406539] Starting Upmpd Daemon
Apr 24 06:53:26 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 06:53:26 volumio volumio[976]: info: Loading plugin "my_music"...
Apr 24 06:53:26 volumio volumio[976]: info: Loading plugin "mpd"...
Apr 24 06:53:26 volumio kernel: Key type cifs.spnego registered
Apr 24 06:53:26 volumio kernel: Key type cifs.idmap registered
Apr 24 06:53:26 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.
Apr 24 06:53:26 volumio kernel: CIFS: Attempting to mount //192.168.1.156/music
Apr 24 06:53:27 volumio volumio[976]: info: Loading plugin "upnp_browser"...
Apr 24 06:53:28 volumio volumio[976]: info: Loading plugin "alarm-clock"...
Apr 24 06:53:28 volumio sh[509]: timed out
Apr 24 06:53:28 volumio dhcpcd[563]: timed out
Apr 24 06:53:28 volumio sh[509]: dhcpcd exited
Apr 24 06:53:28 volumio dhcpcd[563]: dhcpcd exited
Apr 24 06:53:28 volumio sh[509]: ifup: failed to bring up eth0
Apr 24 06:53:28 volumio systemd[1]: ifup@eth0.service: Main process exited, code=exited, status=1/FAILURE
Apr 24 06:53:28 volumio systemd[1]: ifup@eth0.service: Failed with result 'exit-code'.
Apr 24 06:53:29 volumio volumio[976]: info: Loading plugin "airplay_emulation"...
Apr 24 06:53:29 volumio volumio[976]: info: Starting Shairport Sync
Apr 24 06:53:29 volumio volumio[976]: info: Loading plugin "last_100"...
Apr 24 06:53:29 volumio volumio[976]: info: Loading plugin "webradio"...
Apr 24 06:53:29 volumio volumio[976]: info: Loading plugin "i2s_dacs"...
Apr 24 06:53:29 volumio volumio[976]: info: I2S DAC not set, start Auto-detection
Apr 24 06:53:29 volumio volumio[976]: info: Loading plugin "volumiodiscovery"...
Apr 24 06:53:29 volumio volumio[976]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 24 06:53:29 volumio volumio[976]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 06:53:29 volumio volumio[976]: *** WARNING *** For more information see
Apr 24 06:53:29 volumio volumio[976]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 24 06:53:29 volumio volumio[976]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 06:53:29 volumio volumio[976]: *** WARNING *** For more information see
Apr 24 06:53:29 volumio node[976]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi.
Apr 24 06:53:29 volumio node[976]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 06:53:29 volumio node[976]: *** WARNING *** For more information see
Apr 24 06:53:29 volumio node[976]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi.
Apr 24 06:53:29 volumio node[976]: *** WARNING *** Please fix your application to use the native API of Avahi!
Apr 24 06:53:29 volumio node[976]: *** WARNING *** For more information see
Apr 24 06:53:29 volumio volumio[976]: info: Applying required configuration parameters for plugin volumiodiscovery
Apr 24 06:53:29 volumio volumio[976]: info: Discovery: Started advertising with name: Volumio
Apr 24 06:53:29 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback
Apr 24 06:53:29 volumio volumio[976]: info: Loading plugin "spop"...
Apr 24 06:53:33 volumio sudo[1087]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:33 volumio kernel: CIFS: VFS: Error connecting to socket. Aborting operation.
Apr 24 06:53:33 volumio kernel: CIFS: VFS: cifs_mount failed w/return code = -113
Apr 24 06:53:33 volumio systemd[1]: systemd-hostnamed.service: Succeeded.
Apr 24 06:53:34 volumio systemd[1]: apt-daily.service: Succeeded.
Apr 24 06:53:34 volumio systemd[1]: Started Daily apt download activities.
Apr 24 06:53:34 volumio systemd[1]: Starting Daily apt upgrade and clean activities...
Apr 24 06:53:35 volumio volumio[976]: info: Loading plugin "outputs"...
Apr 24 06:53:35 volumio volumio[976]: info: Loading plugin "albumart"...
Apr 24 06:53:35 volumio volumio[976]: info: Plugin example_plugin is not enabled
Apr 24 06:53:35 volumio volumio[976]: info: Loading plugin "inputs"...
Apr 24 06:53:35 volumio volumio[976]: info: Loading plugin "updater_comm"...
Apr 24 06:53:36 volumio volumio[976]: info: Plugin mpdemulation is not enabled
Apr 24 06:53:36 volumio volumio[976]: info: Loading plugin "rest_api"...
Apr 24 06:53:36 volumio volumio[976]: info: Loading plugin "websocket"...
Apr 24 06:53:36 volumio volumio[976]: info: Starting Socket.io Server version 2.3.0
Apr 24 06:53:36 volumio volumio[976]: info: Loading plugin "fusiondsp"...
Apr 24 06:53:36 volumio volumio[976]: Forking 3 albumart workers
Apr 24 06:53:36 volumio systemd[1]: apt-daily-upgrade.service: Succeeded.
Apr 24 06:53:36 volumio systemd[1]: Started Daily apt upgrade and clean activities.
Apr 24 06:53:36 volumio systemd[1]: Startup finished in 16.607s (kernel) + 49.052s (userspace) = 1min 5.659s.
Apr 24 06:53:36 volumio volumio-remote-updater[627]: [2025-04-24 06:53:36] [connect] Successful connection
Apr 24 06:53:37 volumio volumio[976]: Starting albumart workers
Apr 24 06:53:37 volumio volumio[976]: Starting albumart workers
Apr 24 06:53:37 volumio volumio[976]: Starting albumart workers
Apr 24 06:53:48 volumio kernel: hwmon hwmon1: Undervoltage detected!
Apr 24 06:53:50 volumio systemd[1]: systemd-timedated.service: Succeeded.
Apr 24 06:53:51 volumio volumio-remote-updater[627]: [2025-04-24 06:53:51] [connect] Successful connection
Apr 24 06:53:52 volumio volumio[976]: info: Applying required configuration parameters for plugin fusiondsp
Apr 24 06:53:52 volumio kernel: hwmon hwmon1: Voltage normalised
Apr 24 06:53:52 volumio volumio[976]: info: Loading i18n strings for locale fr
Apr 24 06:53:52 volumio volumio[976]: Updating browse sources language
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::initPlayerControls
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 06:53:52 volumio volumio[976]: Express server listening on port 3000
Apr 24 06:53:52 volumio volumio[976]: [Metrics] WebUI: 35s 28.34ms
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::resetVolumioState
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::getcurrentVolume
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioRetrievevolume
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:53 volumio sudo[1280]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0
Apr 24 06:53:53 volumio sudo[1280]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:53 volumio sudo[1280]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:53 volumio sudo[1282]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0
Apr 24 06:53:53 volumio sudo[1282]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:53 volumio sudo[1282]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:53 volumio volumio[976]: info: Volumio Network Manager: Network status updated: 2
Apr 24 06:53:53 volumio volumio[976]: info: Cannot mount NAS music at system boot, trial number 1 ,retrying in 5 seconds
Apr 24 06:53:53 volumio volumio-remote-updater[627]: [2025-04-24 06:53:53] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1745470431 101
Apr 24 06:53:53 volumio volumio[976]: 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
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice
Apr 24 06:53:53 volumio volumio[976]: info: Discovery: Getting this device information
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioGetState
Apr 24 06:53:53 volumio volumio[976]: info: CorePlayQueue::getTrack 0
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 24 06:53:53 volumio volumio[976]: info: VolumeController:: Volume=91 Mute =false
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::pushState
Apr 24 06:53:53 volumio volumio[976]: info: CorePlayQueue::getTrack 0
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioPushState
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::updateTrackBlock
Apr 24 06:53:53 volumio volumio[976]: info: CorePlayQueue::getTrackBlock
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioRetrievevolume
Apr 24 06:53:53 volumio volumio[976]: info: Reloading queue from file
Apr 24 06:53:53 volumio volumio[976]: info: Setting Device type: Raspberry PI
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::setRepeat null single undefined
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::pushState
Apr 24 06:53:53 volumio volumio[976]: info: CorePlayQueue::getTrack 0
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioPushState
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::setRandom null
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::pushState
Apr 24 06:53:53 volumio volumio[976]: info: CorePlayQueue::getTrack 0
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioPushState
Apr 24 06:53:53 volumio volumio[976]: info: VolumeController:: Volume=91 Mute =false
Apr 24 06:53:53 volumio volumio[976]: info: CoreStateMachine::pushState
Apr 24 06:53:53 volumio volumio[976]: info: CorePlayQueue::getTrack 0
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioPushState
Apr 24 06:53:53 volumio sudo[1294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service
Apr 24 06:53:53 volumio sudo[1294]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:53 volumio volumio[976]: info: Completed loading Core Plugins
Apr 24 06:53:53 volumio volumio[976]: info: Preparing to generate the ALSA configuration file
Apr 24 06:53:53 volumio volumio[976]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 24 06:53:53 volumio volumio[976]: info: Reading ALSA contributions from plugins.
Apr 24 06:53:53 volumio volumio[976]: info: Discovery: adding 51e4b970-942c-45b5-b7b9-fbf3085ff1f1
Apr 24 06:53:53 volumio volumio[976]: info: Discovery: Found device Volumio
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioGetState
Apr 24 06:53:53 volumio volumio[976]: info: CorePlayQueue::getTrack 0
Apr 24 06:53:53 volumio volumio[976]: info: Asound.conf file unchanged, so no further update is needed
Apr 24 06:53:53 volumio volumio[976]: info: Output device has changed, restarting MPD
Apr 24 06:53:53 volumio systemd[1]: Started UPnP Renderer front-end to MPD.
Apr 24 06:53:53 volumio sudo[1294]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:53 volumio volumio[976]: info: Output device has changed, restarting Shairport Sync
Apr 24 06:53:53 volumio sudo[1298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:53 volumio sudo[1298]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:53 volumio sudo[1298]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:53 volumio sudo[1300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 24 06:53:53 volumio sudo[1300]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:53 volumio volumio[976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 06:53:53 volumio volumio[976]: info: ___________ START PLUGINS ___________
Apr 24 06:53:53 volumio volumio[976]: info: ControllerMpd::onStart: Initializing MPD
Apr 24 06:53:53 volumio volumio[976]: info: Creating MPD Configuration file
Apr 24 06:53:53 volumio systemd[1]: Stopping Music Player Daemon...
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 06:53:53 volumio volumio[976]: info: [1745470433734] CoreMusicLibrary::Adding element Serveurs Média
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 06:53:53 volumio sudo[1307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 24 06:53:53 volumio sudo[1309]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 24 06:53:53 volumio sudo[1307]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:53 volumio sudo[1309]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:53 volumio sudo[1307]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:53 volumio volumio[976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:53 volumio volumio[976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 06:53:53 volumio volumio[976]: info: [1745470433930] CoreMusicLibrary::Adding element Last_100
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object]
Apr 24 06:53:53 volumio volumio[976]: info: [1745470433934] CoreMusicLibrary::Adding element Webradio
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources
Apr 24 06:53:53 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 24 06:53:53 volumio volumio[976]: info: Initializing BBC Radios
Apr 24 06:53:54 volumio systemd[1]: mpd.service: Succeeded.
Apr 24 06:53:54 volumio systemd[1]: Stopped Music Player Daemon.
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: Creating Spotify config file
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio systemd[1]: Starting Music Player Daemon...
Apr 24 06:53:54 volumio volumio[976]: info: Loading i18n strings for locale fr
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: FusionDsp - mixtype--------------------- Hardware
Apr 24 06:53:54 volumio volumio[976]: info: Volumio Calling Home
Apr 24 06:53:54 volumio sudo[1325]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 24 06:53:54 volumio sudo[1325]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:54 volumio volumio[976]: info: Preparing to generate the ALSA configuration file
Apr 24 06:53:54 volumio sudo[1325]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:54 volumio volumio[976]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf
Apr 24 06:53:54 volumio volumio[976]: info: Reading ALSA contributions from plugins.
Apr 24 06:53:54 volumio volumio[976]: info: MPD Permissions set
Apr 24 06:53:54 volumio volumio[976]: info: Upmpdcli Daemon Started
Apr 24 06:53:54 volumio volumio[976]: 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 24 06:53:54 volumio volumio[976]: info: Spotify config file written
Apr 24 06:53:54 volumio sudo[1335]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart go-librespot-daemon.service
Apr 24 06:53:54 volumio sudo[1335]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:54 volumio systemd[1]: Started go-librespot Daemon.
Apr 24 06:53:54 volumio go-librespot[1337]: go-librespot daemon starting...
Apr 24 06:53:54 volumio sudo[1335]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:54 volumio volumio[976]: info: No need to fix Spotify hosts
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:54 volumio volumio[976]: info: Volumio called home
Apr 24 06:53:54 volumio volumio[976]: info: Starting Shairport Sync
Apr 24 06:53:54 volumio sudo[1348]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 06:53:54 volumio sudo[1348]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:54 volumio volumio[976]: info: CoreCommandRouter::volumioGetState
Apr 24 06:53:54 volumio volumio[976]: info: CorePlayQueue::getTrack 0
Apr 24 06:53:54 volumio volumio[976]: info: Starting Shairport Sync
Apr 24 06:53:54 volumio volumio[976]: info: Starting Shairport Sync
Apr 24 06:53:54 volumio sudo[1351]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 06:53:54 volumio sudo[1351]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:54 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 24 06:53:54 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 24 06:53:54 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 24 06:53:54 volumio sudo[1354]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 06:53:54 volumio sudo[1354]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:54 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 24 06:53:54 volumio sudo[1348]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 24 06:53:55 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM
Apr 24 06:53:55 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 24 06:53:55 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 24 06:53:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 24 06:53:55 volumio sudo[1354]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:55 volumio sudo[1351]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:55 volumio volumio[976]: info: Shairport-Sync Started
Apr 24 06:53:55 volumio volumio[976]: Error adding Membership: Error: addMembership EINVAL
Apr 24 06:53:55 volumio volumio[976]: info: Asound.conf file unchanged, so no further update is needed
Apr 24 06:53:55 volumio volumio[976]: info: Output device has changed, restarting MPD
Apr 24 06:53:55 volumio volumio[976]: info: Output device has changed, restarting Shairport Sync
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:55 volumio sudo[1363]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf
Apr 24 06:53:55 volumio sudo[1363]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:55 volumio sudo[1363]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:55 volumio sudo[1366]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service
Apr 24 06:53:55 volumio sudo[1366]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:55 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM
Apr 24 06:53:55 volumio systemd[1]: mpd.service: Succeeded.
Apr 24 06:53:55 volumio volumio[976]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0
Apr 24 06:53:55 volumio systemd[1]: Stopped Music Player Daemon.
Apr 24 06:53:55 volumio volumio[976]: info: Shairport-Sync Started
Apr 24 06:53:55 volumio volumio[976]: info: Shairport-Sync Started
Apr 24 06:53:55 volumio volumio[976]: info: MPD Permissions set
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio systemd[1]: Starting Music Player Daemon...
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:55 volumio volumio[976]: info: Starting Shairport Sync
Apr 24 06:53:55 volumio sudo[1381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync
Apr 24 06:53:55 volumio sudo[1381]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:55 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver...
Apr 24 06:53:55 volumio systemd[1]: shairport-sync.service: Succeeded.
Apr 24 06:53:55 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver.
Apr 24 06:53:55 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver.
Apr 24 06:53:55 volumio sudo[1381]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:55 volumio sudo[1374]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log
Apr 24 06:53:55 volumio sudo[1374]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:55 volumio volumio[976]: info: Shairport-Sync Started
Apr 24 06:53:55 volumio sudo[1374]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:56 volumio go-librespot[1337]: time="2025-04-24T06:53:56+02:00" level=info msg="running go-librespot 0.2.0"
Apr 24 06:53:56 volumio volumio[976]: info: camilladsp service started and running in background, instance 1
Apr 24 06:53:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam
Apr 24 06:53:56 volumio go-librespot[1337]: time="2025-04-24T06:53:56+02:00" level=debug msg="app state loaded"
Apr 24 06:53:56 volumio go-librespot[1337]: time="2025-04-24T06:53:56+02:00" level=debug msg="stored credentials not found"
Apr 24 06:53:56 volumio go-librespot[1337]: time="2025-04-24T06:53:56+02:00" level=info msg="api server listening on 127.0.0.1:9879"
Apr 24 06:53:56 volumio volumio[976]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Apr 24 06:53:56 volumio volumio[976]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json
Apr 24 06:53:56 volumio volumio[976]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found
Apr 24 06:53:56 volumio volumio[976]: info: FusionDsp loaded
Apr 24 06:53:56 volumio volumio[976]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses
Apr 24 06:53:56 volumio sudo[1413]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service
Apr 24 06:53:56 volumio sudo[1413]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:56 volumio volumio[976]: info: FusionDsp - Reporting Fusion DSP Enabled
Apr 24 06:53:56 volumio volumio[976]: info: Adding Signal Path Element [object Object]
Apr 24 06:53:56 volumio volumio[976]: info: Adding fusiondspeq DSP Signal Path Element
Apr 24 06:53:56 volumio volumio[976]: info: FusionDsp - ---- installed callbackRead
Apr 24 06:53:56 volumio volumio[976]: |||||||||||||||||||||||| WARNING: FATAL ERROR |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 06:53:56 volumio volumio[976]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT
Apr 24 06:53:56 volumio volumio[976]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19)
Apr 24 06:53:56 volumio volumio[976]: at onErrorNT (internal/child_process.js:465:16)
Apr 24 06:53:56 volumio volumio[976]: at processTicksAndRejections (internal/process/task_queues.js:80:21) {
Apr 24 06:53:56 volumio volumio[976]: errno: -2,
Apr 24 06:53:56 volumio volumio[976]: code: 'ENOENT',
Apr 24 06:53:56 volumio volumio[976]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp',
Apr 24 06:53:56 volumio volumio[976]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp',
Apr 24 06:53:56 volumio volumio[976]: spawnargs: [
Apr 24 06:53:56 volumio volumio[976]: '-p',
Apr 24 06:53:56 volumio volumio[976]: 9876,
Apr 24 06:53:56 volumio volumio[976]: '-o',
Apr 24 06:53:56 volumio volumio[976]: '/tmp/camilladsp.log',
Apr 24 06:53:56 volumio volumio[976]: '-l',
Apr 24 06:53:56 volumio volumio[976]: 'warn',
Apr 24 06:53:56 volumio volumio[976]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml'
Apr 24 06:53:56 volumio volumio[976]: ]
Apr 24 06:53:56 volumio volumio[976]: }
Apr 24 06:53:56 volumio volumio[976]: |||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||
Apr 24 06:53:56 volumio systemd[1]: Started FusionDsp Daemon.
Apr 24 06:53:56 volumio sudo[1413]: pam_unix(sudo:session): session closed for user root
Apr 24 06:53:56 volumio mpd[1387]: Apr 24 06:53 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg
Apr 24 06:53:57 volumio sudo[1425]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-04-24 06:52
Apr 24 06:53:57 volumio sudo[1425]: pam_unix(sudo:session): session opened for user root by (uid=0)
Apr 24 06:53:57 volumio volumio[1415]: /usr/bin/python3: can't open file '/data/plugins/audio_interface/fusiondsp/cgui/main.py': [Errno 2] No such file or directory
Apr 24 06:53:57 volumio systemd[1]: fusiondsp.service: Main process exited, code=exited, status=2/INVALIDARGUMENT
Apr 24 06:53:57 volumio systemd[1]: fusiondsp.service: Failed with result 'exit-code'.
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="a01a833dd28483f88cb390596f5090b7187992af"
VOLUMIO_ARCH="arm"
VOLUMIO_VARIANT="volumio"
VOLUMIO_TEST="FALSE"
VOLUMIO_BUILD_DATE="Thu 27 Feb 2025 11:42:54 AM CET"
VOLUMIO_VERSION="3.795"
VOLUMIO_HARDWARE="pi"
VOLUMIO_DEVICENAME="Raspberry Pi"
VOLUMIO_HASH="4049a67f1c09d4a94e033ba35a80a144"