-- Logs begin at Thu 2019-02-14 10:11:59 GMT, end at Thu 2025-05-22 17:12:53 BST. -- May 22 17:12:43 volumiopi systemd-timedated[1015]: Changed local time to Thu May 22 17:12:43 2025 May 22 17:12:43 volumiopi sudo[1013]: pam_unix(sudo:session): session closed for user root May 22 17:12:43 volumiopi volumio-time-update[607]: volumio-time-update-util: System time updated successfully. May 22 17:12:43 volumiopi systemd[1]: Started Volumio Time Update Utility. May 22 17:12:43 volumiopi systemd[1]: Reached target Multi-User System. May 22 17:12:43 volumiopi systemd[1]: Reached target Graphical Interface. May 22 17:12:43 volumiopi systemd[1]: Starting Update UTMP about System Runlevel Changes... May 22 17:12:43 volumiopi systemd[1]: systemd-update-utmp-runlevel.service: Succeeded. May 22 17:12:43 volumiopi systemd[1]: Started Update UTMP about System Runlevel Changes. May 22 17:12:43 volumiopi systemd[1]: Startup finished in 13.525s (kernel) + 21.752s (userspace) = 35.278s. May 22 17:12:43 volumiopi volumio[970]: info: MYVOLUMIO Environment detected May 22 17:12:43 volumiopi nmbd[767]: [2025/05/22 17:12:43.551543, 0] ../source3/nmbd/nmbd_namequery.c:109(query_name_response) May 22 17:12:43 volumiopi nmbd[767]: query_name_response: Multiple (2) responses received for a query on subnet 192.168.0.8 for name WORKGROUP<1d>. May 22 17:12:43 volumiopi nmbd[767]: This response was from IP 192.168.0.2, reporting an IP address of 192.168.0.2. May 22 17:12:43 volumiopi volumio[970]: info: Plugin folders cleanup May 22 17:12:43 volumiopi volumio[970]: info: Scanning into folder /volumio/app/plugins/ May 22 17:12:43 volumiopi volumio[970]: info: Scanning category audio_interface May 22 17:12:43 volumiopi volumio[970]: info: Scanning category miscellanea May 22 17:12:43 volumiopi volumio[970]: info: Scanning category music_service May 22 17:12:43 volumiopi volumio[970]: info: Scanning category plugins.json May 22 17:12:43 volumiopi volumio[970]: info: Scanning category system_controller May 22 17:12:43 volumiopi volumio[970]: info: Scanning category user_interface May 22 17:12:43 volumiopi volumio[970]: info: Scanning into folder /data/plugins/ May 22 17:12:43 volumiopi volumio[970]: info: Scanning category audio_interface May 22 17:12:43 volumiopi volumio[970]: info: Scanning category system_controller May 22 17:12:43 volumiopi volumio[970]: info: Plugin folders cleanup completed May 22 17:12:43 volumiopi volumio[970]: info: ------------------------------------------- May 22 17:12:43 volumiopi volumio[970]: info: ----- Core plugins startup ---- May 22 17:12:43 volumiopi volumio[970]: info: ------------------------------------------- May 22 17:12:43 volumiopi volumio[970]: info: Loading plugins from folder /volumio/app/plugins/ May 22 17:12:43 volumiopi volumio[970]: info: Adding plugin upnp to MyMusic Plugins May 22 17:12:43 volumiopi volumio[970]: info: Adding plugin airplay_emulation to MyMusic Plugins May 22 17:12:43 volumiopi volumio[970]: info: Adding plugin upnp_browser to MyMusic Plugins May 22 17:12:43 volumiopi volumio[970]: info: Loading plugins from folder /data/plugins/ May 22 17:12:43 volumiopi volumio[970]: info: Loading plugin "system"... May 22 17:12:43 volumiopi volumio[970]: info: Loading plugin "appearance"... May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "network"... May 22 17:12:45 volumiopi volumio[970]: info: Refreshing Cached IP Addresses May 22 17:12:45 volumiopi sudo[1023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 May 22 17:12:45 volumiopi sudo[1023]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:45 volumiopi sudo[1025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 May 22 17:12:45 volumiopi sudo[1025]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:45 volumiopi sudo[1023]: pam_unix(sudo:session): session closed for user root May 22 17:12:45 volumiopi sudo[1025]: pam_unix(sudo:session): session closed for user root May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "services"... May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "alsa_controller"... May 22 17:12:45 volumiopi sudo[1034]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan May 22 17:12:45 volumiopi sudo[1034]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:45 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "wizard"... May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "networkfs"... May 22 17:12:45 volumiopi volumio[970]: info: Starting Udev Watcher for removable devices May 22 17:12:45 volumiopi sudo[1051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount -t cifs -o username=daphile,password=Muzyka.1,ro,dir_mode=0777,file_mode=0666,iocharset=utf8,noauto,soft //192.168.0.4/music /mnt/NAS/Synology May 22 17:12:45 volumiopi sudo[1051]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:45 volumiopi volumio[970]: info: Ignoring mount for partition: boot May 22 17:12:45 volumiopi volumio[970]: info: Ignoring mount for partition: volumio May 22 17:12:45 volumiopi volumio[970]: info: Ignoring mount for partition: volumio_data May 22 17:12:45 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "volumio_command_line_client"... May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "upnp"... May 22 17:12:45 volumiopi volumio[970]: info: [1747930365727] Starting Upmpd Daemon May 22 17:12:45 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "my_music"... May 22 17:12:45 volumiopi volumio[970]: info: Loading plugin "mpd"... May 22 17:12:45 volumiopi kernel: Key type cifs.spnego registered May 22 17:12:45 volumiopi kernel: Key type cifs.idmap registered May 22 17:12:45 volumiopi 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. May 22 17:12:45 volumiopi kernel: CIFS: Attempting to mount //192.168.0.4/music May 22 17:12:46 volumiopi volumio[970]: info: Loading plugin "upnp_browser"... May 22 17:12:46 volumiopi sudo[1051]: pam_unix(sudo:session): session closed for user root May 22 17:12:46 volumiopi sudo[1034]: pam_unix(sudo:session): session closed for user root May 22 17:12:46 volumiopi volumio[970]: info: Loading plugin "alarm-clock"... May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "airplay_emulation"... May 22 17:12:47 volumiopi volumio[970]: info: Starting Shairport Sync May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "last_100"... May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "webradio"... May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "i2s_dacs"... May 22 17:12:47 volumiopi volumio[970]: info: I2S DAC not set, start Auto-detection May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "volumiodiscovery"... May 22 17:12:47 volumiopi volumio[970]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 22 17:12:47 volumiopi volumio[970]: *** WARNING *** Please fix your application to use the native API of Avahi! May 22 17:12:47 volumiopi volumio[970]: *** WARNING *** For more information see May 22 17:12:47 volumiopi node[970]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. May 22 17:12:47 volumiopi volumio[970]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 22 17:12:47 volumiopi volumio[970]: *** WARNING *** Please fix your application to use the native API of Avahi! May 22 17:12:47 volumiopi volumio[970]: *** WARNING *** For more information see May 22 17:12:47 volumiopi node[970]: *** WARNING *** Please fix your application to use the native API of Avahi! May 22 17:12:47 volumiopi node[970]: *** WARNING *** For more information see May 22 17:12:47 volumiopi node[970]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. May 22 17:12:47 volumiopi node[970]: *** WARNING *** Please fix your application to use the native API of Avahi! May 22 17:12:47 volumiopi node[970]: *** WARNING *** For more information see May 22 17:12:47 volumiopi volumio[970]: info: Applying required configuration parameters for plugin volumiodiscovery May 22 17:12:47 volumiopi volumio[970]: info: Discovery: Started advertising with name: VolumioPi May 22 17:12:47 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "autostart"... May 22 17:12:47 volumiopi volumio[970]: info: Applying required configuration parameters for plugin autostart May 22 17:12:47 volumiopi volumio[970]: info: AutoStart - onVolumioStart - read config.json May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "outputs"... May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "albumart"... May 22 17:12:47 volumiopi volumio[970]: info: Plugin example_plugin is not enabled May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "inputs"... May 22 17:12:47 volumiopi volumio[970]: info: Loading plugin "updater_comm"... May 22 17:12:48 volumiopi volumio[970]: info: Plugin mpdemulation is not enabled May 22 17:12:48 volumiopi volumio[970]: info: Loading plugin "rest_api"... May 22 17:12:48 volumiopi volumio[970]: info: Loading plugin "websocket"... May 22 17:12:48 volumiopi volumio[970]: info: Starting Socket.io Server version 2.3.0 May 22 17:12:48 volumiopi volumio[970]: info: Loading plugin "fusiondsp"... May 22 17:12:48 volumiopi volumio[970]: Forking 3 albumart workers May 22 17:12:48 volumiopi volumio[970]: info: Applying required configuration parameters for plugin fusiondsp May 22 17:12:48 volumiopi volumio[970]: info: Loading i18n strings for locale pl May 22 17:12:48 volumiopi volumio[970]: Updating browse sources language May 22 17:12:48 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 22 17:12:49 volumiopi volumio[970]: Starting albumart workers May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::initPlayerControls May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:49 volumiopi volumio[970]: Starting albumart workers May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 22 17:12:49 volumiopi volumio[970]: Express server listening on port 3000 May 22 17:12:49 volumiopi volumio[970]: [Metrics] WebUI: 8s 60.09ms May 22 17:12:49 volumiopi volumio[970]: Starting albumart workers May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::resetVolumioState May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::getcurrentVolume May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::volumioRetrievevolume May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:49 volumiopi volumio[970]: info: Volumio Network Manager: Network status updated: 2 May 22 17:12:49 volumiopi volumio[970]: verbose: New Socket.io Connection to 192.168.0.8:3000 from 192.168.0.7 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 1 May 22 17:12:49 volumiopi volumio[970]: verbose: New Socket.io Connection to 192.168.0.8:3000 from 192.168.0.7 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::volumioGetState May 22 17:12:49 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:49 volumiopi volumio-remote-updater[589]: [2025-05-22 17:12:49] [connect] Successful connection May 22 17:12:49 volumiopi volumio[970]: info: Reloading queue from file May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , initSocket May 22 17:12:49 volumiopi volumio[970]: info: VolumeController:: Volume=0 Mute =false May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::pushState May 22 17:12:49 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::volumioPushState May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::updateTrackBlock May 22 17:12:49 volumiopi volumio[970]: info: CorePlayQueue::getTrackBlock May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::volumioRetrievevolume May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::setRepeat null single undefined May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::pushState May 22 17:12:49 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::volumioPushState May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::setRandom null May 22 17:12:49 volumiopi volumio[970]: info: CoreStateMachine::pushState May 22 17:12:49 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:49 volumiopi volumio[970]: info: CoreCommandRouter::volumioPushState May 22 17:12:49 volumiopi volumio[970]: info: Setting Device type: Raspberry PI May 22 17:12:50 volumiopi volumio[970]: info: Listing playlists May 22 17:12:50 volumiopi volumio[970]: info: Listing playlists May 22 17:12:50 volumiopi volumio-remote-updater[589]: [2025-05-22 17:12:50] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1747930369 101 May 22 17:12:50 volumiopi volumio[970]: 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: 3 May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::volumioGetState May 22 17:12:50 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:50 volumiopi volumio[970]: info: Completed loading Core Plugins May 22 17:12:50 volumiopi volumio[970]: info: Preparing to generate the ALSA configuration file May 22 17:12:50 volumiopi volumio[970]: info: Discovery: adding 8fb1e1c8-fc9d-4a44-9915-ace891a4c314 May 22 17:12:50 volumiopi volumio[970]: info: Discovery: Found device VolumioPi May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::volumioGetState May 22 17:12:50 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:50 volumiopi volumio[970]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 22 17:12:50 volumiopi volumio[970]: info: Reading ALSA contributions from plugins. May 22 17:12:50 volumiopi volumio[970]: info: Discovery: adding 12ef70b5-2e29-4466-ab71-dc1c1aea59d9 May 22 17:12:50 volumiopi volumio[970]: info: Discovery: Found device Volumio May 22 17:12:50 volumiopi volumio[970]: info: Discovery: Connecting to remote: 192.168.0.7 May 22 17:12:50 volumiopi volumio[970]: info: VolumeController:: Volume=0 Mute =false May 22 17:12:50 volumiopi volumio[970]: info: CoreStateMachine::pushState May 22 17:12:50 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::volumioPushState May 22 17:12:50 volumiopi volumio[970]: info: Asound.conf file unchanged, so no further update is needed May 22 17:12:50 volumiopi volumio[970]: info: Output device has changed, restarting MPD May 22 17:12:50 volumiopi volumio[970]: info: Output device has changed, restarting Shairport Sync May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:50 volumiopi sudo[1145]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 22 17:12:50 volumiopi sudo[1145]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:50 volumiopi sudo[1145]: pam_unix(sudo:session): session closed for user root May 22 17:12:50 volumiopi sudo[1147]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 22 17:12:50 volumiopi sudo[1147]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:50 volumiopi systemd[1]: Stopping Music Player Daemon... May 22 17:12:50 volumiopi volumio[970]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 22 17:12:50 volumiopi volumio[970]: info: ___________ START PLUGINS ___________ May 22 17:12:50 volumiopi volumio[970]: info: ControllerMpd::onStart: Initializing MPD May 22 17:12:50 volumiopi volumio[970]: info: Creating MPD Configuration file May 22 17:12:50 volumiopi sudo[1154]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 22 17:12:50 volumiopi sudo[1154]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam May 22 17:12:50 volumiopi sudo[1154]: pam_unix(sudo:session): session closed for user root May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 22 17:12:50 volumiopi volumio[970]: info: [1747930370438] CoreMusicLibrary::Adding element Serwery Mediów May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 17:12:50 volumiopi sudo[1157]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 22 17:12:50 volumiopi sudo[1157]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:50 volumiopi volumio[970]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:50 volumiopi systemd[1]: mpd.service: Succeeded. May 22 17:12:50 volumiopi systemd[1]: Stopped Music Player Daemon. May 22 17:12:50 volumiopi volumio[970]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 22 17:12:50 volumiopi volumio[970]: info: [1747930370588] CoreMusicLibrary::Adding element Last_100 May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] May 22 17:12:50 volumiopi volumio[970]: info: [1747930370592] CoreMusicLibrary::Adding element Webradio May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 17:12:50 volumiopi volumio[970]: info: Initializing BBC Radios May 22 17:12:50 volumiopi systemd[1]: Starting Music Player Daemon... May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:50 volumiopi volumio[970]: info: AutoStart - onStart May 22 17:12:50 volumiopi volumio[970]: info: Loading i18n strings for locale pl May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile May 22 17:12:50 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:50 volumiopi volumio[970]: info: FusionDsp - mixtype--------------------- Hardware May 22 17:12:50 volumiopi volumio[970]: info: Volumio Calling Home May 22 17:12:50 volumiopi sudo[1163]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 22 17:12:50 volumiopi sudo[1163]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:50 volumiopi sudo[1163]: pam_unix(sudo:session): session closed for user root May 22 17:12:50 volumiopi volumio[970]: info: Preparing to generate the ALSA configuration file May 22 17:12:50 volumiopi volumio[970]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf May 22 17:12:50 volumiopi volumio[970]: info: Reading ALSA contributions from plugins. May 22 17:12:50 volumiopi volumio[970]: info: MPD Permissions set May 22 17:12:50 volumiopi volumio[970]: info: MPD Permissions set May 22 17:12:50 volumiopi volumio[970]: info: Discovery: Connected to remote: 192.168.0.7 May 22 17:12:50 volumiopi volumio[970]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 May 22 17:12:50 volumiopi volumio[970]: info: Volumio called home May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: Starting Shairport Sync May 22 17:12:51 volumiopi volumio[970]: info: Starting Shairport Sync May 22 17:12:51 volumiopi volumio[970]: info: Starting Shairport Sync May 22 17:12:51 volumiopi sudo[1190]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 22 17:12:51 volumiopi sudo[1190]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:51 volumiopi sudo[1192]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 22 17:12:51 volumiopi sudo[1192]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:51 volumiopi sudo[1195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::volumioGetState May 22 17:12:51 volumiopi volumio[970]: info: CorePlayQueue::getTrack 0 May 22 17:12:51 volumiopi sudo[1195]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:51 volumiopi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 22 17:12:51 volumiopi systemd[1]: shairport-sync.service: Succeeded. May 22 17:12:51 volumiopi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 22 17:12:51 volumiopi volumio[970]: info: Asound.conf file unchanged, so no further update is needed May 22 17:12:51 volumiopi volumio[970]: info: Output device has changed, restarting MPD May 22 17:12:51 volumiopi sudo[1190]: pam_unix(sudo:session): session closed for user root May 22 17:12:51 volumiopi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 22 17:12:51 volumiopi sudo[1192]: pam_unix(sudo:session): session closed for user root May 22 17:12:51 volumiopi volumio[970]: info: Output device has changed, restarting Shairport Sync May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:51 volumiopi sudo[1200]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf May 22 17:12:51 volumiopi sudo[1200]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:51 volumiopi sudo[1195]: pam_unix(sudo:session): session closed for user root May 22 17:12:51 volumiopi sudo[1200]: pam_unix(sudo:session): session closed for user root May 22 17:12:51 volumiopi sudo[1203]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service May 22 17:12:51 volumiopi sudo[1203]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:51 volumiopi systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM May 22 17:12:51 volumiopi systemd[1]: mpd.service: Succeeded. May 22 17:12:51 volumiopi systemd[1]: Stopped Music Player Daemon. May 22 17:12:51 volumiopi volumio[970]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 May 22 17:12:51 volumiopi volumio[970]: info: MPD Permissions set May 22 17:12:51 volumiopi volumio[970]: info: Shairport-Sync Started May 22 17:12:51 volumiopi volumio[970]: Error adding Membership: Error: addMembership EINVAL May 22 17:12:51 volumiopi volumio[970]: info: Shairport-Sync Started May 22 17:12:51 volumiopi volumio[970]: info: Shairport-Sync Started May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi systemd[1]: Starting Music Player Daemon... May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:51 volumiopi volumio[970]: info: Starting Shairport Sync May 22 17:12:51 volumiopi sudo[1216]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync May 22 17:12:51 volumiopi sudo[1216]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:51 volumiopi systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... May 22 17:12:51 volumiopi systemd[1]: shairport-sync.service: Succeeded. May 22 17:12:51 volumiopi systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. May 22 17:12:51 volumiopi systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. May 22 17:12:51 volumiopi sudo[1216]: pam_unix(sudo:session): session closed for user root May 22 17:12:51 volumiopi volumio[970]: info: Shairport-Sync Started May 22 17:12:51 volumiopi sudo[1210]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log May 22 17:12:51 volumiopi sudo[1210]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:51 volumiopi sudo[1210]: pam_unix(sudo:session): session closed for user root May 22 17:12:52 volumiopi volumio[970]: info: camilladsp service started and running in background, instance 1 May 22 17:12:52 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam May 22 17:12:52 volumiopi volumio[970]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 22 17:12:52 volumiopi volumio[970]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json May 22 17:12:52 volumiopi volumio[970]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found May 22 17:12:52 volumiopi volumio[970]: info: FusionDsp loaded May 22 17:12:52 volumiopi volumio[970]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses May 22 17:12:52 volumiopi sudo[1235]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service May 22 17:12:52 volumiopi sudo[1235]: pam_unix(sudo:session): session opened for user root by (uid=0) May 22 17:12:52 volumiopi volumio[970]: info: FusionDsp - Reporting Fusion DSP Enabled May 22 17:12:52 volumiopi volumio[970]: info: Adding Signal Path Element [object Object] May 22 17:12:52 volumiopi sudo[1235]: pam_unix(sudo:session): session closed for user root May 22 17:12:52 volumiopi volumio[970]: info: Adding fusiondspeq DSP Signal Path Element May 22 17:12:52 volumiopi volumio[970]: info: FusionDsp - ---- installed callbackRead May 22 17:12:52 volumiopi volumio[970]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 17:12:52 volumiopi volumio[970]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT May 22 17:12:52 volumiopi volumio[970]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) May 22 17:12:52 volumiopi volumio[970]: at onErrorNT (internal/child_process.js:465:16) May 22 17:12:52 volumiopi volumio[970]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { May 22 17:12:52 volumiopi volumio[970]: errno: -2, May 22 17:12:52 volumiopi volumio[970]: code: 'ENOENT', May 22 17:12:52 volumiopi volumio[970]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', May 22 17:12:52 volumiopi volumio[970]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', May 22 17:12:52 volumiopi volumio[970]: spawnargs: [ May 22 17:12:52 volumiopi volumio[970]: '-p', May 22 17:12:52 volumiopi volumio[970]: 9876, May 22 17:12:52 volumiopi volumio[970]: '-o', May 22 17:12:52 volumiopi volumio[970]: '/tmp/camilladsp.log', May 22 17:12:52 volumiopi volumio[970]: '-l', May 22 17:12:52 volumiopi volumio[970]: 'warn', May 22 17:12:52 volumiopi volumio[970]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' May 22 17:12:52 volumiopi volumio[970]: ] May 22 17:12:52 volumiopi volumio[970]: } May 22 17:12:52 volumiopi volumio[970]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| May 22 17:12:53 volumiopi mpd[1220]: May 22 17:12 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg May 22 17:12:53 volumiopi systemd[1]: Started Music Player Daemon. May 22 17:12:53 volumiopi sudo[1147]: pam_unix(sudo:session): session closed for user root May 22 17:12:53 volumiopi sudo[1203]: pam_unix(sudo:session): session closed for user root May 22 17:12:53 volumiopi sudo[1157]: pam_unix(sudo:session): session closed for user root May 22 17:12:53 volumiopi sudo[1249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-05-22 17:11 May 22 17:12:53 volumiopi sudo[1249]: 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="570c5791513f5bac7da274aba6690c1a961705de" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="35e4a13c94df42ebab19fd6178d6be47190c244d" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Tue 13 May 2025 05:16:30 PM CEST" VOLUMIO_VERSION="3.812" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="3934ee440d5d3f0186049a23752ad680"