-- Logs begin at Thu 2019-02-14 10:11:58 GMT, end at Sun 2025-03-16 10:35:01 GMT. -- Mar 16 10:34:00 volumio systemd[2879]: Starting D-Bus User Message Bus Socket. Mar 16 10:34:00 volumio systemd[2879]: Listening on GnuPG cryptographic agent and passphrase cache. Mar 16 10:34:00 volumio systemd[2879]: Listening on GnuPG network certificate management daemon. Mar 16 10:34:00 volumio systemd[2879]: Listening on GnuPG cryptographic agent and passphrase cache (access for web browsers). Mar 16 10:34:00 volumio systemd[2879]: Listening on GnuPG cryptographic agent (ssh-agent emulation). Mar 16 10:34:00 volumio systemd[2879]: Listening on Sound System. Mar 16 10:34:00 volumio systemd[2879]: Listening on D-Bus User Message Bus Socket. Mar 16 10:34:00 volumio systemd[2879]: Reached target Sockets. Mar 16 10:34:00 volumio systemd[2879]: Reached target Basic System. Mar 16 10:34:00 volumio systemd[2879]: Reached target Default. Mar 16 10:34:00 volumio systemd[2879]: Startup finished in 263ms. Mar 16 10:34:00 volumio systemd[1]: Started User Manager for UID 1000. Mar 16 10:34:00 volumio systemd[1]: Started Session 1 of user volumio. Mar 16 10:34:00 volumio volumio[2851]: info: MYVOLUMIO Environment detected Mar 16 10:34:00 volumio volumio[2851]: info: Plugin folders cleanup Mar 16 10:34:00 volumio volumio[2851]: info: Scanning into folder /volumio/app/plugins/ Mar 16 10:34:00 volumio volumio[2851]: info: Scanning category audio_interface Mar 16 10:34:00 volumio volumio[2851]: info: Scanning category miscellanea Mar 16 10:34:00 volumio volumio[2851]: info: Scanning category music_service Mar 16 10:34:00 volumio volumio[2851]: info: Scanning category plugins.json Mar 16 10:34:00 volumio volumio[2851]: info: Scanning category system_controller Mar 16 10:34:00 volumio volumio[2851]: info: Scanning category user_interface Mar 16 10:34:00 volumio volumio[2851]: info: Scanning into folder /data/plugins/ Mar 16 10:34:00 volumio volumio[2851]: info: Scanning category audio_interface Mar 16 10:34:00 volumio volumio[2851]: info: Plugin folders cleanup completed Mar 16 10:34:00 volumio volumio[2851]: info: ------------------------------------------- Mar 16 10:34:00 volumio volumio[2851]: info: ----- Core plugins startup ---- Mar 16 10:34:00 volumio volumio[2851]: info: ------------------------------------------- Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugins from folder /volumio/app/plugins/ Mar 16 10:34:00 volumio volumio[2851]: info: Adding plugin upnp to MyMusic Plugins Mar 16 10:34:00 volumio volumio[2851]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 16 10:34:00 volumio volumio[2851]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugins from folder /data/plugins/ Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugin "system"... Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugin "appearance"... Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugin "network"... Mar 16 10:34:00 volumio volumio[2851]: info: Refreshing Cached IP Addresses Mar 16 10:34:00 volumio sudo[2899]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 16 10:34:00 volumio sudo[2899]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:00 volumio sudo[2899]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:00 volumio sudo[2901]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 16 10:34:00 volumio sudo[2901]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:00 volumio sudo[2901]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugin "services"... Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugin "alsa_controller"... Mar 16 10:34:00 volumio sudo[2910]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 16 10:34:00 volumio sudo[2910]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:00 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugin "wizard"... Mar 16 10:34:00 volumio volumio[2851]: info: Loading plugin "networkfs"... Mar 16 10:34:01 volumio volumio[2851]: info: Starting Udev Watcher for removable devices Mar 16 10:34:01 volumio volumio[2851]: info: Ignoring mount for partition: boot Mar 16 10:34:01 volumio volumio[2851]: info: Ignoring mount for partition: volumio Mar 16 10:34:01 volumio volumio[2851]: info: Ignoring mount for partition: volumio_data Mar 16 10:34:01 volumio volumio[2851]: info: Mounting Device Music Mar 16 10:34:01 volumio sudo[2930]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:01 volumio sudo[2930]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:01 volumio ntfs-3g[2933]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 16 10:34:01 volumio ntfs-3g[2933]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Mar 16 10:34:01 volumio ntfs-3g[2933]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:01 volumio ntfs-3g[2933]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 16 10:34:01 volumio ntfs-3g[2933]: Global ownership and permissions enforced, configuration type 7 Mar 16 10:34:01 volumio sudo[2930]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:01 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "volumio_command_line_client"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "upnp"... Mar 16 10:34:01 volumio volumio[2851]: info: [1742121241147] Starting Upmpd Daemon Mar 16 10:34:01 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "my_music"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "mpd"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "upnp_browser"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "alarm-clock"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "airplay_emulation"... Mar 16 10:34:01 volumio volumio[2851]: info: Starting Shairport Sync Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "last_100"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "webradio"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "i2s_dacs"... Mar 16 10:34:01 volumio volumio[2851]: info: I2S DAC not set, start Auto-detection Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "volumiodiscovery"... Mar 16 10:34:01 volumio volumio[2851]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:01 volumio volumio[2851]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:01 volumio volumio[2851]: *** WARNING *** For more information see Mar 16 10:34:01 volumio node[2851]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:01 volumio volumio[2851]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:01 volumio volumio[2851]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:01 volumio volumio[2851]: *** WARNING *** For more information see Mar 16 10:34:01 volumio node[2851]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:01 volumio node[2851]: *** WARNING *** For more information see Mar 16 10:34:01 volumio node[2851]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:01 volumio node[2851]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:01 volumio node[2851]: *** WARNING *** For more information see Mar 16 10:34:01 volumio volumio[2851]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 16 10:34:01 volumio volumio[2851]: info: Discovery: Started advertising with name: Volumio Mar 16 10:34:01 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "outputs"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "albumart"... Mar 16 10:34:01 volumio volumio[2851]: info: Plugin example_plugin is not enabled Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "inputs"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "updater_comm"... Mar 16 10:34:01 volumio volumio[2851]: info: Plugin mpdemulation is not enabled Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "rest_api"... Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "websocket"... Mar 16 10:34:01 volumio volumio[2851]: info: Starting Socket.io Server version 2.3.0 Mar 16 10:34:01 volumio volumio[2851]: info: Loading plugin "fusiondsp"... Mar 16 10:34:01 volumio volumio[2851]: Forking 3 albumart workers Mar 16 10:34:02 volumio volumio[2851]: info: Applying required configuration parameters for plugin fusiondsp Mar 16 10:34:02 volumio volumio[2851]: info: Loading i18n strings for locale pl Mar 16 10:34:02 volumio volumio[2851]: Updating browse sources language Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::initPlayerControls Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: Starting albumart workers Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: Express server listening on port 3000 Mar 16 10:34:02 volumio volumio[2851]: [Metrics] WebUI: 3s 176.73ms Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::resetVolumioState Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::getcurrentVolume Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:02 volumio volumio[2851]: Starting albumart workers Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:02 volumio volumio[2851]: info: Volumio Network Manager: Network status updated: 2 Mar 16 10:34:02 volumio volumio[2851]: Starting albumart workers Mar 16 10:34:02 volumio volumio[2851]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 16 10:34:02 volumio volumio[2851]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 2 Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::setRepeat null single undefined Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::pushState Mar 16 10:34:02 volumio volumio[2851]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::setRandom null Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::pushState Mar 16 10:34:02 volumio volumio[2851]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:02 volumio volumio[2851]: info: Setting Device type: Raspberry PI Mar 16 10:34:02 volumio volumio[2851]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 16 10:34:02 volumio volumio[2851]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 16 10:34:02 volumio volumio[2851]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 16 10:34:02 volumio volumio[2851]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::pushState Mar 16 10:34:02 volumio volumio[2851]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:02 volumio volumio[2851]: info: CoreStateMachine::updateTrackBlock Mar 16 10:34:02 volumio volumio[2851]: info: CorePlayQueue::getTrackBlock Mar 16 10:34:02 volumio volumio[2851]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:03 volumio volumio[2851]: info: Completed loading Core Plugins Mar 16 10:34:03 volumio volumio[2851]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:03 volumio volumio[2851]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:03 volumio volumio[2851]: info: Reading ALSA contributions from plugins. Mar 16 10:34:03 volumio volumio[2851]: info: Reloading queue from file Mar 16 10:34:03 volumio volumio[2851]: info: Discovery: adding daf3d5df-fe0e-4e5d-8bee-1bbabba64c0f Mar 16 10:34:03 volumio volumio[2851]: info: Discovery: Found device Volumio Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:03 volumio volumio[2851]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:03 volumio volumio[2851]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:03 volumio volumio[2851]: info: CoreStateMachine::pushState Mar 16 10:34:03 volumio volumio[2851]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:03 volumio volumio[2851]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:03 volumio volumio[2851]: info: Output device has changed, restarting MPD Mar 16 10:34:03 volumio sudo[3004]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:03 volumio sudo[3004]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio volumio[2851]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:03 volumio sudo[3004]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:03 volumio sudo[3007]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:03 volumio sudo[3007]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio systemd[1]: Stopping Music Player Daemon... Mar 16 10:34:03 volumio volumio[2851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:03 volumio volumio[2851]: info: ___________ START PLUGINS ___________ Mar 16 10:34:03 volumio volumio[2851]: info: ControllerMpd::onStart: Initializing MPD Mar 16 10:34:03 volumio volumio[2851]: info: Creating MPD Configuration file Mar 16 10:34:03 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:03 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:03 volumio sudo[3014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:03 volumio sudo[3014]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:03 volumio volumio[2851]: info: [1742121243373] CoreMusicLibrary::Adding element Serwery Mediów Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:03 volumio sudo[3014]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:03 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:03 volumio sudo[3016]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:03 volumio sudo[3016]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 16 10:34:03 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:03 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:03 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:03 volumio volumio-remote-updater[509]: [2025-03-16 10:34:03] [connect] Successful connection Mar 16 10:34:03 volumio volumio[2851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:03 volumio volumio[2851]: info: [1742121243495] CoreMusicLibrary::Adding element Last_100 Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:03 volumio volumio[2851]: info: [1742121243497] CoreMusicLibrary::Adding element Webradio Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:03 volumio volumio[2851]: info: Initializing BBC Radios Mar 16 10:34:03 volumio sudo[3022]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:03 volumio sudo[3022]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio sudo[3022]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: Loading i18n strings for locale pl Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: FusionDsp - mixtype--------------------- Hardware Mar 16 10:34:03 volumio volumio[2851]: info: Volumio Calling Home Mar 16 10:34:03 volumio volumio[2851]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:03 volumio volumio[2851]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:03 volumio volumio[2851]: info: Reading ALSA contributions from plugins. Mar 16 10:34:03 volumio volumio[2851]: info: MPD Permissions set Mar 16 10:34:03 volumio volumio[2851]: info: MPD Permissions set Mar 16 10:34:03 volumio volumio-remote-updater[509]: [2025-03-16 10:34:03] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742121243 101 Mar 16 10:34:03 volumio volumio[2851]: 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 Mar 16 10:34:03 volumio volumio[2851]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: Volumio called home Mar 16 10:34:03 volumio volumio[2851]: info: Starting Shairport Sync Mar 16 10:34:03 volumio volumio[2851]: info: Starting Shairport Sync Mar 16 10:34:03 volumio volumio[2851]: info: Starting Shairport Sync Mar 16 10:34:03 volumio sudo[3050]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:03 volumio sudo[3050]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio sudo[3052]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:03 volumio sudo[3052]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:03 volumio volumio[2851]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:03 volumio sudo[3055]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:03 volumio sudo[3055]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio volumio[2851]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:03 volumio volumio[2851]: info: Output device has changed, restarting MPD Mar 16 10:34:03 volumio volumio[2851]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:03 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:03 volumio sudo[3059]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:03 volumio sudo[3059]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio sudo[3059]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:03 volumio sudo[3061]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:03 volumio sudo[3061]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:03 volumio volumio[2851]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:03 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:03 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:03 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:03 volumio volumio[2851]: info: MPD Permissions set Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:04 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:04 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:04 volumio volumio[2851]: info: Starting Shairport Sync Mar 16 10:34:04 volumio sudo[3073]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:04 volumio sudo[3073]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:04 volumio sudo[3067]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:04 volumio sudo[3067]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:04 volumio sudo[3067]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:04 volumio sudo[2910]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:04 volumio mpd[3076]: Mar 16 10:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 16 10:34:04 volumio systemd[1]: Started Music Player Daemon. Mar 16 10:34:04 volumio sudo[3007]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:04 volumio sudo[3016]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:04 volumio sudo[3061]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:04 volumio volumio[2851]: info: Completed starting Core Plugins Mar 16 10:34:04 volumio volumio[2851]: info: ------------------------------------------- Mar 16 10:34:04 volumio volumio[2851]: info: ----- MyVolumio plugins startup ---- Mar 16 10:34:04 volumio volumio[2851]: info: ------------------------------------------- Mar 16 10:34:04 volumio volumio[2851]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 16 10:34:04 volumio volumio[2851]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:04 volumio volumio[2851]: assert.ok(self.idling) Mar 16 10:34:04 volumio volumio[2851]: error: The expression evaluated to a falsy value: Mar 16 10:34:04 volumio volumio[2851]: assert.ok(self.idling) Mar 16 10:34:04 volumio volumio[2851]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:04 volumio volumio[2851]: assert.ok(self.idling) Mar 16 10:34:04 volumio volumio[2851]: error: The expression evaluated to a falsy value: Mar 16 10:34:04 volumio volumio[2851]: assert.ok(self.idling) Mar 16 10:34:04 volumio volumio[2851]: info: MPD running with PID3076 Mar 16 10:34:04 volumio volumio[2851]: ,establishing connection Mar 16 10:34:04 volumio volumio[2851]: error: updateQueue error: null Mar 16 10:34:04 volumio volumio[2851]: error: updateQueue error: null Mar 16 10:34:05 volumio volumio[2851]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:05 volumio volumio[2851]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Mar 16 10:34:05 volumio volumio[2851]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:05 volumio volumio[2851]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 16 10:34:05 volumio volumio[2851]: info: camilladsp service started and running in background, instance 1 Mar 16 10:34:05 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:05 volumio volumio[2851]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:05 volumio volumio[2851]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 16 10:34:05 volumio volumio[2851]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:05 volumio volumio[2851]: info: FusionDsp loaded Mar 16 10:34:05 volumio volumio[2851]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:05 volumio sudo[3092]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 16 10:34:05 volumio sudo[3092]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:05 volumio volumio[2851]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 16 10:34:05 volumio volumio[2851]: info: Adding Signal Path Element [object Object] Mar 16 10:34:05 volumio volumio[2851]: info: Adding fusiondspeq DSP Signal Path Element Mar 16 10:34:05 volumio volumio[2851]: info: FusionDsp - ---- installed callbackRead Mar 16 10:34:05 volumio volumio[2851]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:05 volumio sudo[3092]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:05 volumio volumio[2851]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 16 10:34:05 volumio volumio[2851]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 16 10:34:05 volumio volumio[2851]: at onErrorNT (internal/child_process.js:465:16) Mar 16 10:34:05 volumio volumio[2851]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Mar 16 10:34:05 volumio volumio[2851]: errno: -2, Mar 16 10:34:05 volumio volumio[2851]: code: 'ENOENT', Mar 16 10:34:05 volumio volumio[2851]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:05 volumio volumio[2851]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:05 volumio volumio[2851]: spawnargs: [ Mar 16 10:34:05 volumio volumio[2851]: '-p', Mar 16 10:34:05 volumio volumio[2851]: 9876, Mar 16 10:34:05 volumio volumio[2851]: '-o', Mar 16 10:34:05 volumio volumio[2851]: '/tmp/camilladsp.log', Mar 16 10:34:05 volumio volumio[2851]: '-l', Mar 16 10:34:05 volumio volumio[2851]: 'warn', Mar 16 10:34:05 volumio volumio[2851]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 16 10:34:05 volumio volumio[2851]: ] Mar 16 10:34:05 volumio volumio[2851]: } Mar 16 10:34:05 volumio volumio[2851]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:05 volumio sudo[3103]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 10:33 Mar 16 10:34:05 volumio sudo[3103]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:06 volumio sudo[3103]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:06 volumio volumio-remote-updater[509]: [2025-03-16 10:34:06] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 16 10:34:06 volumio volumio-remote-updater[509]: [2025-03-16 10:34:06] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 16 10:34:06 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 16 10:34:06 volumio sudo[3050]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:06 volumio sudo[3073]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:06 volumio systemd[2879]: media-Music.mount: Succeeded. Mar 16 10:34:06 volumio sudo[3052]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:06 volumio systemd[1]: media-Music.mount: Succeeded. Mar 16 10:34:06 volumio ntfs-3g[2933]: Unmounting /dev/sda1 (Music) Mar 16 10:34:06 volumio sudo[3055]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:06 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 16 10:34:06 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:06 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:06 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 16 10:34:06 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 9. Mar 16 10:34:06 volumio systemd[1]: Stopped Volumio Backend Module. Mar 16 10:34:06 volumio systemd[1]: Started Volumio Backend Module. Mar 16 10:34:06 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:06 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:07 volumio volumio[3114]: info: ------------------------------------------- Mar 16 10:34:07 volumio volumio[3114]: info: ----- Volumio3 ---- Mar 16 10:34:07 volumio volumio[3114]: info: ------------------------------------------- Mar 16 10:34:07 volumio volumio[3114]: info: ----- System startup ---- Mar 16 10:34:07 volumio volumio[3114]: info: ------------------------------------------- Mar 16 10:34:07 volumio volumio[3114]: info: MYVOLUMIO Environment detected Mar 16 10:34:07 volumio volumio[3114]: info: Plugin folders cleanup Mar 16 10:34:07 volumio volumio[3114]: info: Scanning into folder /volumio/app/plugins/ Mar 16 10:34:07 volumio volumio[3114]: info: Scanning category audio_interface Mar 16 10:34:07 volumio volumio[3114]: info: Scanning category miscellanea Mar 16 10:34:07 volumio volumio[3114]: info: Scanning category music_service Mar 16 10:34:07 volumio volumio[3114]: info: Scanning category plugins.json Mar 16 10:34:07 volumio volumio[3114]: info: Scanning category system_controller Mar 16 10:34:07 volumio volumio[3114]: info: Scanning category user_interface Mar 16 10:34:07 volumio volumio[3114]: info: Scanning into folder /data/plugins/ Mar 16 10:34:07 volumio volumio[3114]: info: Scanning category audio_interface Mar 16 10:34:07 volumio volumio[3114]: info: Plugin folders cleanup completed Mar 16 10:34:07 volumio volumio[3114]: info: ------------------------------------------- Mar 16 10:34:07 volumio volumio[3114]: info: ----- Core plugins startup ---- Mar 16 10:34:07 volumio volumio[3114]: info: ------------------------------------------- Mar 16 10:34:07 volumio volumio[3114]: info: Loading plugins from folder /volumio/app/plugins/ Mar 16 10:34:07 volumio volumio[3114]: info: Adding plugin upnp to MyMusic Plugins Mar 16 10:34:07 volumio volumio[3114]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 16 10:34:07 volumio volumio[3114]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 16 10:34:07 volumio volumio[3114]: info: Loading plugins from folder /data/plugins/ Mar 16 10:34:07 volumio volumio[3114]: info: Loading plugin "system"... Mar 16 10:34:07 volumio volumio[3114]: info: Loading plugin "appearance"... Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "network"... Mar 16 10:34:08 volumio volumio[3114]: info: Refreshing Cached IP Addresses Mar 16 10:34:08 volumio sudo[3141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 16 10:34:08 volumio sudo[3141]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:08 volumio sudo[3141]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:08 volumio sudo[3143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 16 10:34:08 volumio sudo[3143]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:08 volumio sudo[3143]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "services"... Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "alsa_controller"... Mar 16 10:34:08 volumio sudo[3152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 16 10:34:08 volumio sudo[3152]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:08 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "wizard"... Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "networkfs"... Mar 16 10:34:08 volumio volumio[3114]: info: Starting Udev Watcher for removable devices Mar 16 10:34:08 volumio volumio[3114]: info: Ignoring mount for partition: boot Mar 16 10:34:08 volumio volumio[3114]: info: Ignoring mount for partition: volumio Mar 16 10:34:08 volumio volumio[3114]: info: Ignoring mount for partition: volumio_data Mar 16 10:34:08 volumio volumio[3114]: info: Mounting Device Music Mar 16 10:34:08 volumio sudo[3172]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:08 volumio sudo[3172]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:08 volumio ntfs-3g[3175]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 16 10:34:08 volumio ntfs-3g[3175]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Mar 16 10:34:08 volumio ntfs-3g[3175]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:08 volumio ntfs-3g[3175]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 16 10:34:08 volumio ntfs-3g[3175]: Global ownership and permissions enforced, configuration type 7 Mar 16 10:34:08 volumio sudo[3172]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:08 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "volumio_command_line_client"... Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "upnp"... Mar 16 10:34:08 volumio volumio[3114]: info: [1742121248815] Starting Upmpd Daemon Mar 16 10:34:08 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "my_music"... Mar 16 10:34:08 volumio volumio[3114]: info: Loading plugin "mpd"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "upnp_browser"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "alarm-clock"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "airplay_emulation"... Mar 16 10:34:09 volumio volumio[3114]: info: Starting Shairport Sync Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "last_100"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "webradio"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "i2s_dacs"... Mar 16 10:34:09 volumio volumio[3114]: info: I2S DAC not set, start Auto-detection Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "volumiodiscovery"... Mar 16 10:34:09 volumio volumio[3114]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:09 volumio volumio[3114]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:09 volumio volumio[3114]: *** WARNING *** For more information see Mar 16 10:34:09 volumio node[3114]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:09 volumio volumio[3114]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:09 volumio volumio[3114]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:09 volumio volumio[3114]: *** WARNING *** For more information see Mar 16 10:34:09 volumio node[3114]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:09 volumio node[3114]: *** WARNING *** For more information see Mar 16 10:34:09 volumio node[3114]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:09 volumio node[3114]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:09 volumio node[3114]: *** WARNING *** For more information see Mar 16 10:34:09 volumio volumio[3114]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 16 10:34:09 volumio volumio[3114]: info: Discovery: Started advertising with name: Volumio Mar 16 10:34:09 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "outputs"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "albumart"... Mar 16 10:34:09 volumio volumio[3114]: info: Plugin example_plugin is not enabled Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "inputs"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "updater_comm"... Mar 16 10:34:09 volumio volumio[3114]: info: Plugin mpdemulation is not enabled Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "rest_api"... Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "websocket"... Mar 16 10:34:09 volumio volumio[3114]: info: Starting Socket.io Server version 2.3.0 Mar 16 10:34:09 volumio volumio[3114]: info: Loading plugin "fusiondsp"... Mar 16 10:34:09 volumio volumio[3114]: Forking 3 albumart workers Mar 16 10:34:09 volumio volumio[3114]: info: Applying required configuration parameters for plugin fusiondsp Mar 16 10:34:09 volumio volumio[3114]: info: Loading i18n strings for locale pl Mar 16 10:34:09 volumio volumio[3114]: Updating browse sources language Mar 16 10:34:09 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::initPlayerControls Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: Express server listening on port 3000 Mar 16 10:34:10 volumio volumio[3114]: [Metrics] WebUI: 2s 946.64ms Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::resetVolumioState Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::getcurrentVolume Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: Volumio Network Manager: Network status updated: 2 Mar 16 10:34:10 volumio volumio[3114]: Starting albumart workers Mar 16 10:34:10 volumio volumio[3114]: Starting albumart workers Mar 16 10:34:10 volumio volumio[3114]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 16 10:34:10 volumio volumio[3114]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::pushState Mar 16 10:34:10 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::updateTrackBlock Mar 16 10:34:10 volumio volumio[3114]: info: CorePlayQueue::getTrackBlock Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:10 volumio volumio[3114]: Starting albumart workers Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::setRepeat null single undefined Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::pushState Mar 16 10:34:10 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::setRandom null Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::pushState Mar 16 10:34:10 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:10 volumio volumio[3114]: info: Setting Device type: Raspberry PI Mar 16 10:34:10 volumio volumio[3114]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 16 10:34:10 volumio volumio[3114]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 16 10:34:10 volumio volumio[3114]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 16 10:34:10 volumio volumio[3114]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:10 volumio volumio[3114]: info: CoreStateMachine::pushState Mar 16 10:34:10 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:10 volumio volumio[3114]: info: Completed loading Core Plugins Mar 16 10:34:10 volumio volumio[3114]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:10 volumio volumio[3114]: info: Reloading queue from file Mar 16 10:34:10 volumio volumio[3114]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:10 volumio volumio[3114]: info: Reading ALSA contributions from plugins. Mar 16 10:34:10 volumio volumio[3114]: info: Discovery: adding daf3d5df-fe0e-4e5d-8bee-1bbabba64c0f Mar 16 10:34:10 volumio volumio[3114]: info: Discovery: Found device Volumio Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:10 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:10 volumio volumio[3114]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:10 volumio volumio[3114]: info: Output device has changed, restarting MPD Mar 16 10:34:10 volumio sudo[3227]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:10 volumio sudo[3227]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:10 volumio volumio[3114]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:10 volumio sudo[3227]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:10 volumio sudo[3229]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:10 volumio sudo[3229]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:10 volumio volumio[3114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:10 volumio volumio[3114]: info: ___________ START PLUGINS ___________ Mar 16 10:34:10 volumio systemd[1]: Stopping Music Player Daemon... Mar 16 10:34:10 volumio volumio[3114]: info: ControllerMpd::onStart: Initializing MPD Mar 16 10:34:10 volumio volumio[3114]: info: Creating MPD Configuration file Mar 16 10:34:10 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:10 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:10 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:10 volumio volumio[3114]: info: [1742121250869] CoreMusicLibrary::Adding element Serwery Mediów Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:10 volumio sudo[3249]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:10 volumio sudo[3249]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:10 volumio sudo[3255]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:10 volumio sudo[3255]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:10 volumio sudo[3249]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:10 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 16 10:34:10 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:10 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:10 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:10 volumio volumio[3114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:10 volumio volumio[3114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:10 volumio volumio[3114]: info: [1742121250982] CoreMusicLibrary::Adding element Last_100 Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:10 volumio volumio[3114]: info: [1742121250986] CoreMusicLibrary::Adding element Webradio Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:10 volumio sudo[3258]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:10 volumio sudo[3258]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:10 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:10 volumio volumio[3114]: info: Initializing BBC Radios Mar 16 10:34:10 volumio sudo[3258]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: Loading i18n strings for locale pl Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: FusionDsp - mixtype--------------------- Hardware Mar 16 10:34:11 volumio volumio[3114]: info: Volumio Calling Home Mar 16 10:34:11 volumio volumio-remote-updater[509]: [2025-03-16 10:34:11] [connect] Successful connection Mar 16 10:34:11 volumio volumio[3114]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:11 volumio volumio[3114]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:11 volumio volumio[3114]: info: Reading ALSA contributions from plugins. Mar 16 10:34:11 volumio volumio[3114]: info: MPD Permissions set Mar 16 10:34:11 volumio volumio[3114]: info: MPD Permissions set Mar 16 10:34:11 volumio volumio-remote-updater[509]: [2025-03-16 10:34:11] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742121251 101 Mar 16 10:34:11 volumio volumio[3114]: 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: 2 Mar 16 10:34:11 volumio volumio[3114]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: Volumio called home Mar 16 10:34:11 volumio volumio[3114]: info: Starting Shairport Sync Mar 16 10:34:11 volumio volumio[3114]: info: Starting Shairport Sync Mar 16 10:34:11 volumio sudo[3289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:11 volumio volumio[3114]: info: Starting Shairport Sync Mar 16 10:34:11 volumio sudo[3289]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:11 volumio sudo[3291]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:11 volumio sudo[3291]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:11 volumio sudo[3294]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:11 volumio sudo[3294]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:11 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:11 volumio volumio[3114]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:11 volumio volumio[3114]: info: Output device has changed, restarting MPD Mar 16 10:34:11 volumio volumio[3114]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:11 volumio sudo[3298]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:11 volumio sudo[3298]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:11 volumio sudo[3298]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:11 volumio sudo[3300]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:11 volumio sudo[3300]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:11 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:11 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:11 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:11 volumio volumio[3114]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:11 volumio volumio[3114]: info: MPD Permissions set Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:11 volumio volumio[3114]: info: Starting Shairport Sync Mar 16 10:34:11 volumio sudo[3312]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:11 volumio sudo[3312]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:11 volumio sudo[3306]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:11 volumio sudo[3306]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:11 volumio sudo[3306]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:11 volumio volumio[3114]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 4 Mar 16 10:34:11 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::volumioGetVisibleSources Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:12 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:12 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 16 10:34:12 volumio volumio[3114]: info: Received Get System Info Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 10:34:12 volumio volumio[3114]: info: Discovery: Getting this device information Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:12 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:12 volumio volumio[3114]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:12 volumio volumio[3114]: info: Listing playlists Mar 16 10:34:12 volumio sudo[3152]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:12 volumio mpd[3315]: Mar 16 10:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 16 10:34:12 volumio systemd[1]: Started Music Player Daemon. Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:12 volumio sudo[3300]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:12 volumio sudo[3229]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:12 volumio sudo[3255]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:12 volumio volumio[3114]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:12 volumio volumio[3114]: info: Completed starting Core Plugins Mar 16 10:34:12 volumio volumio[3114]: info: ------------------------------------------- Mar 16 10:34:12 volumio volumio[3114]: info: ----- MyVolumio plugins startup ---- Mar 16 10:34:12 volumio volumio[3114]: info: ------------------------------------------- Mar 16 10:34:12 volumio volumio[3114]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 16 10:34:12 volumio volumio[3114]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:12 volumio volumio[3114]: assert.ok(self.idling) Mar 16 10:34:12 volumio volumio[3114]: error: The expression evaluated to a falsy value: Mar 16 10:34:12 volumio volumio[3114]: assert.ok(self.idling) Mar 16 10:34:12 volumio volumio[3114]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:12 volumio volumio[3114]: assert.ok(self.idling) Mar 16 10:34:12 volumio volumio[3114]: error: The expression evaluated to a falsy value: Mar 16 10:34:12 volumio volumio[3114]: assert.ok(self.idling) Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - Mar 16 10:34:12 volumio volumio[3114]: info: MPD running with PID3315 Mar 16 10:34:12 volumio volumio[3114]: ,establishing connection Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - undefined Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - undefined Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - undefined Mar 16 10:34:12 volumio volumio[3114]: info: FusionDsp - undefined Mar 16 10:34:13 volumio volumio[3114]: error: updateQueue error: null Mar 16 10:34:13 volumio volumio[3114]: error: updateQueue error: null Mar 16 10:34:13 volumio volumio[3114]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:13 volumio volumio[3114]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Mar 16 10:34:13 volumio volumio[3114]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:13 volumio volumio[3114]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 16 10:34:13 volumio volumio[3114]: info: camilladsp service started and running in background, instance 1 Mar 16 10:34:13 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:13 volumio volumio[3114]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:13 volumio volumio[3114]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 16 10:34:13 volumio volumio[3114]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:13 volumio volumio[3114]: info: FusionDsp loaded Mar 16 10:34:13 volumio volumio[3114]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:13 volumio sudo[3331]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 16 10:34:13 volumio sudo[3331]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:13 volumio volumio[3114]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 16 10:34:13 volumio volumio[3114]: info: Adding Signal Path Element [object Object] Mar 16 10:34:13 volumio volumio[3114]: info: Adding fusiondspeq DSP Signal Path Element Mar 16 10:34:13 volumio volumio[3114]: info: FusionDsp - ---- installed callbackRead Mar 16 10:34:13 volumio volumio[3114]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:13 volumio sudo[3331]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:13 volumio volumio[3114]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 16 10:34:13 volumio volumio[3114]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 16 10:34:13 volumio volumio[3114]: at onErrorNT (internal/child_process.js:465:16) Mar 16 10:34:13 volumio volumio[3114]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 16 10:34:13 volumio volumio[3114]: at runNextTicks (internal/process/task_queues.js:62:3) Mar 16 10:34:13 volumio volumio[3114]: at listOnTimeout (internal/timers.js:523:9) Mar 16 10:34:13 volumio volumio[3114]: at processTimers (internal/timers.js:497:7) { Mar 16 10:34:13 volumio volumio[3114]: errno: -2, Mar 16 10:34:13 volumio volumio[3114]: code: 'ENOENT', Mar 16 10:34:13 volumio volumio[3114]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:13 volumio volumio[3114]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:13 volumio volumio[3114]: spawnargs: [ Mar 16 10:34:13 volumio volumio[3114]: '-p', Mar 16 10:34:13 volumio volumio[3114]: 9876, Mar 16 10:34:13 volumio volumio[3114]: '-o', Mar 16 10:34:13 volumio volumio[3114]: '/tmp/camilladsp.log', Mar 16 10:34:13 volumio volumio[3114]: '-l', Mar 16 10:34:13 volumio volumio[3114]: 'warn', Mar 16 10:34:13 volumio volumio[3114]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 16 10:34:13 volumio volumio[3114]: ] Mar 16 10:34:13 volumio volumio[3114]: } Mar 16 10:34:13 volumio volumio[3114]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:13 volumio sudo[3343]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 10:33 Mar 16 10:34:13 volumio sudo[3343]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:13 volumio sudo[3343]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:13 volumio volumio-remote-updater[509]: [2025-03-16 10:34:13] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 16 10:34:13 volumio volumio-remote-updater[509]: [2025-03-16 10:34:13] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 16 10:34:13 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 16 10:34:13 volumio ntfs-3g[3175]: Unmounting /dev/sda1 (Music) Mar 16 10:34:13 volumio systemd[2879]: media-Music.mount: Succeeded. Mar 16 10:34:13 volumio sudo[3294]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:13 volumio sudo[3289]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:13 volumio sudo[3291]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:13 volumio systemd[1]: media-Music.mount: Succeeded. Mar 16 10:34:13 volumio sudo[3312]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:13 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 16 10:34:13 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:13 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:13 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 16 10:34:13 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 10. Mar 16 10:34:13 volumio systemd[1]: Stopped Volumio Backend Module. Mar 16 10:34:14 volumio systemd[1]: Started Volumio Backend Module. Mar 16 10:34:14 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:14 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:14 volumio volumio[3354]: info: ------------------------------------------- Mar 16 10:34:14 volumio volumio[3354]: info: ----- Volumio3 ---- Mar 16 10:34:14 volumio volumio[3354]: info: ------------------------------------------- Mar 16 10:34:14 volumio volumio[3354]: info: ----- System startup ---- Mar 16 10:34:14 volumio volumio[3354]: info: ------------------------------------------- Mar 16 10:34:15 volumio volumio[3354]: info: MYVOLUMIO Environment detected Mar 16 10:34:15 volumio volumio[3354]: info: Plugin folders cleanup Mar 16 10:34:15 volumio volumio[3354]: info: Scanning into folder /volumio/app/plugins/ Mar 16 10:34:15 volumio volumio[3354]: info: Scanning category audio_interface Mar 16 10:34:15 volumio volumio[3354]: info: Scanning category miscellanea Mar 16 10:34:15 volumio volumio[3354]: info: Scanning category music_service Mar 16 10:34:15 volumio volumio[3354]: info: Scanning category plugins.json Mar 16 10:34:15 volumio volumio[3354]: info: Scanning category system_controller Mar 16 10:34:15 volumio volumio[3354]: info: Scanning category user_interface Mar 16 10:34:15 volumio volumio[3354]: info: Scanning into folder /data/plugins/ Mar 16 10:34:15 volumio volumio[3354]: info: Scanning category audio_interface Mar 16 10:34:15 volumio volumio[3354]: info: Plugin folders cleanup completed Mar 16 10:34:15 volumio volumio[3354]: info: ------------------------------------------- Mar 16 10:34:15 volumio volumio[3354]: info: ----- Core plugins startup ---- Mar 16 10:34:15 volumio volumio[3354]: info: ------------------------------------------- Mar 16 10:34:15 volumio volumio[3354]: info: Loading plugins from folder /volumio/app/plugins/ Mar 16 10:34:15 volumio volumio[3354]: info: Adding plugin upnp to MyMusic Plugins Mar 16 10:34:15 volumio volumio[3354]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 16 10:34:15 volumio volumio[3354]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 16 10:34:15 volumio volumio[3354]: info: Loading plugins from folder /data/plugins/ Mar 16 10:34:15 volumio volumio[3354]: info: Loading plugin "system"... Mar 16 10:34:15 volumio volumio[3354]: info: Loading plugin "appearance"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "network"... Mar 16 10:34:16 volumio volumio[3354]: info: Refreshing Cached IP Addresses Mar 16 10:34:16 volumio sudo[3381]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 16 10:34:16 volumio sudo[3381]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:16 volumio sudo[3381]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:16 volumio sudo[3383]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 16 10:34:16 volumio sudo[3383]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:16 volumio sudo[3383]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "services"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "alsa_controller"... Mar 16 10:34:16 volumio sudo[3392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 16 10:34:16 volumio sudo[3392]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:16 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "wizard"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "networkfs"... Mar 16 10:34:16 volumio volumio[3354]: info: Starting Udev Watcher for removable devices Mar 16 10:34:16 volumio volumio[3354]: info: Ignoring mount for partition: boot Mar 16 10:34:16 volumio volumio[3354]: info: Ignoring mount for partition: volumio Mar 16 10:34:16 volumio volumio[3354]: info: Ignoring mount for partition: volumio_data Mar 16 10:34:16 volumio volumio[3354]: info: Mounting Device Music Mar 16 10:34:16 volumio sudo[3412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:16 volumio sudo[3412]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:16 volumio ntfs-3g[3415]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 16 10:34:16 volumio ntfs-3g[3415]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Mar 16 10:34:16 volumio ntfs-3g[3415]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:16 volumio ntfs-3g[3415]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 16 10:34:16 volumio ntfs-3g[3415]: Global ownership and permissions enforced, configuration type 7 Mar 16 10:34:16 volumio sudo[3412]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:16 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "volumio_command_line_client"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "upnp"... Mar 16 10:34:16 volumio volumio[3354]: info: [1742121256320] Starting Upmpd Daemon Mar 16 10:34:16 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "my_music"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "mpd"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "upnp_browser"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "alarm-clock"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "airplay_emulation"... Mar 16 10:34:16 volumio volumio[3354]: info: Starting Shairport Sync Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "last_100"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "webradio"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "i2s_dacs"... Mar 16 10:34:16 volumio volumio[3354]: info: I2S DAC not set, start Auto-detection Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "volumiodiscovery"... Mar 16 10:34:16 volumio volumio[3354]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:16 volumio volumio[3354]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:16 volumio node[3354]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:16 volumio volumio[3354]: *** WARNING *** For more information see Mar 16 10:34:16 volumio volumio[3354]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:16 volumio volumio[3354]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:16 volumio volumio[3354]: *** WARNING *** For more information see Mar 16 10:34:16 volumio node[3354]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:16 volumio node[3354]: *** WARNING *** For more information see Mar 16 10:34:16 volumio node[3354]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:16 volumio node[3354]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:16 volumio node[3354]: *** WARNING *** For more information see Mar 16 10:34:16 volumio volumio[3354]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 16 10:34:16 volumio volumio[3354]: info: Discovery: Started advertising with name: Volumio Mar 16 10:34:16 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "outputs"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "albumart"... Mar 16 10:34:16 volumio volumio[3354]: info: Plugin example_plugin is not enabled Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "inputs"... Mar 16 10:34:16 volumio volumio[3354]: info: Loading plugin "updater_comm"... Mar 16 10:34:17 volumio volumio[3354]: info: Plugin mpdemulation is not enabled Mar 16 10:34:17 volumio volumio[3354]: info: Loading plugin "rest_api"... Mar 16 10:34:17 volumio volumio[3354]: info: Loading plugin "websocket"... Mar 16 10:34:17 volumio volumio[3354]: info: Starting Socket.io Server version 2.3.0 Mar 16 10:34:17 volumio volumio[3354]: info: Loading plugin "fusiondsp"... Mar 16 10:34:17 volumio volumio[3354]: Forking 3 albumart workers Mar 16 10:34:17 volumio volumio[3354]: info: Applying required configuration parameters for plugin fusiondsp Mar 16 10:34:17 volumio volumio[3354]: info: Loading i18n strings for locale pl Mar 16 10:34:17 volumio volumio[3354]: Updating browse sources language Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::initPlayerControls Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: Express server listening on port 3000 Mar 16 10:34:17 volumio volumio[3354]: Starting albumart workers Mar 16 10:34:17 volumio volumio[3354]: [Metrics] WebUI: 3s 127.58ms Mar 16 10:34:17 volumio volumio[3354]: Starting albumart workers Mar 16 10:34:17 volumio volumio[3354]: Starting albumart workers Mar 16 10:34:17 volumio volumio[3354]: info: CoreStateMachine::resetVolumioState Mar 16 10:34:17 volumio volumio[3354]: info: CoreStateMachine::getcurrentVolume Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:17 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:17 volumio volumio[3354]: info: Volumio Network Manager: Network status updated: 2 Mar 16 10:34:18 volumio volumio[3354]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 16 10:34:18 volumio volumio[3354]: info: CoreStateMachine::setRepeat null single undefined Mar 16 10:34:18 volumio volumio[3354]: info: CoreStateMachine::pushState Mar 16 10:34:18 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:18 volumio volumio[3354]: info: CoreStateMachine::setRandom null Mar 16 10:34:18 volumio volumio[3354]: info: CoreStateMachine::pushState Mar 16 10:34:18 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:18 volumio volumio[3354]: info: Setting Device type: Raspberry PI Mar 16 10:34:18 volumio volumio[3354]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 16 10:34:18 volumio volumio[3354]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 16 10:34:18 volumio volumio[3354]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 16 10:34:18 volumio volumio[3354]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:18 volumio volumio[3354]: info: CoreStateMachine::pushState Mar 16 10:34:18 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:18 volumio volumio[3354]: info: CoreStateMachine::updateTrackBlock Mar 16 10:34:18 volumio volumio[3354]: info: CorePlayQueue::getTrackBlock Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:18 volumio volumio[3354]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 2 Mar 16 10:34:18 volumio volumio[3354]: info: Completed loading Core Plugins Mar 16 10:34:18 volumio volumio[3354]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:18 volumio volumio[3354]: info: Reloading queue from file Mar 16 10:34:18 volumio volumio[3354]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:18 volumio volumio[3354]: info: Reading ALSA contributions from plugins. Mar 16 10:34:18 volumio volumio[3354]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:18 volumio volumio[3354]: info: CoreStateMachine::pushState Mar 16 10:34:18 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:18 volumio volumio[3354]: info: Discovery: adding daf3d5df-fe0e-4e5d-8bee-1bbabba64c0f Mar 16 10:34:18 volumio volumio[3354]: info: Discovery: Found device Volumio Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:18 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:18 volumio volumio[3354]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:18 volumio volumio[3354]: info: Output device has changed, restarting MPD Mar 16 10:34:18 volumio sudo[3484]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:18 volumio sudo[3484]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:18 volumio volumio[3354]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:18 volumio sudo[3484]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:18 volumio sudo[3486]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:18 volumio sudo[3486]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:18 volumio systemd[1]: Stopping Music Player Daemon... Mar 16 10:34:18 volumio volumio[3354]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:18 volumio volumio[3354]: info: ___________ START PLUGINS ___________ Mar 16 10:34:18 volumio volumio[3354]: info: ControllerMpd::onStart: Initializing MPD Mar 16 10:34:18 volumio volumio[3354]: info: Creating MPD Configuration file Mar 16 10:34:18 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:18 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:18 volumio sudo[3494]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:18 volumio sudo[3494]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:18 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:18 volumio volumio[3354]: info: [1742121258535] CoreMusicLibrary::Adding element Serwery Mediów Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:18 volumio sudo[3494]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:18 volumio sudo[3496]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:18 volumio sudo[3496]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:18 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 16 10:34:18 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:18 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:18 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:18 volumio volumio[3354]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:18 volumio volumio[3354]: info: [1742121258646] CoreMusicLibrary::Adding element Last_100 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:18 volumio volumio[3354]: info: [1742121258649] CoreMusicLibrary::Adding element Webradio Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:18 volumio volumio[3354]: info: Initializing BBC Radios Mar 16 10:34:18 volumio sudo[3502]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:18 volumio sudo[3502]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:18 volumio sudo[3502]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:18 volumio volumio-remote-updater[509]: [2025-03-16 10:34:18] [connect] Successful connection Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: Loading i18n strings for locale pl Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: FusionDsp - mixtype--------------------- Hardware Mar 16 10:34:18 volumio volumio[3354]: info: Volumio Calling Home Mar 16 10:34:18 volumio volumio[3354]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:18 volumio volumio[3354]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:18 volumio volumio[3354]: info: Reading ALSA contributions from plugins. Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 16 10:34:18 volumio volumio[3354]: info: MPD Permissions set Mar 16 10:34:18 volumio volumio[3354]: info: MPD Permissions set Mar 16 10:34:18 volumio volumio-remote-updater[509]: [2025-03-16 10:34:18] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742121258 101 Mar 16 10:34:18 volumio volumio[3354]: 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 Mar 16 10:34:18 volumio volumio[3354]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:18 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: Volumio called home Mar 16 10:34:19 volumio volumio[3354]: info: Starting Shairport Sync Mar 16 10:34:19 volumio volumio[3354]: info: Starting Shairport Sync Mar 16 10:34:19 volumio volumio[3354]: info: Starting Shairport Sync Mar 16 10:34:19 volumio sudo[3530]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:19 volumio sudo[3530]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:19 volumio sudo[3532]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:19 volumio sudo[3532]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:19 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:19 volumio sudo[3535]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:19 volumio sudo[3535]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:19 volumio volumio[3354]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:19 volumio volumio[3354]: info: Output device has changed, restarting MPD Mar 16 10:34:19 volumio sudo[3539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:19 volumio sudo[3539]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:19 volumio volumio[3354]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:19 volumio sudo[3539]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:19 volumio sudo[3541]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:19 volumio sudo[3541]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:19 volumio volumio[3354]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:19 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:19 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:19 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::volumioGetVisibleSources Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:19 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:19 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 16 10:34:19 volumio volumio[3354]: info: Received Get System Info Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 10:34:19 volumio volumio[3354]: info: Discovery: Getting this device information Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:19 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:19 volumio volumio[3354]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:19 volumio volumio[3354]: info: Listing playlists Mar 16 10:34:19 volumio volumio[3354]: info: MPD Permissions set Mar 16 10:34:19 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:19 volumio volumio[3354]: info: Starting Shairport Sync Mar 16 10:34:19 volumio sudo[3547]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:19 volumio sudo[3553]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:19 volumio sudo[3547]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:19 volumio sudo[3553]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:19 volumio sudo[3547]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:19 volumio volumio[3354]: info: FusionDsp - Mar 16 10:34:19 volumio volumio[3354]: info: FusionDsp - undefined Mar 16 10:34:19 volumio sudo[3392]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:19 volumio volumio[3354]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:19 volumio volumio[3354]: info: FusionDsp - Mar 16 10:34:19 volumio volumio[3354]: info: FusionDsp - Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - Mar 16 10:34:20 volumio mpd[3556]: Mar 16 10:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - Mar 16 10:34:20 volumio systemd[1]: Started Music Player Daemon. Mar 16 10:34:20 volumio sudo[3496]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:20 volumio sudo[3486]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:20 volumio sudo[3541]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - undefined Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - undefined Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - undefined Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - undefined Mar 16 10:34:20 volumio volumio[3354]: info: Completed starting Core Plugins Mar 16 10:34:20 volumio volumio[3354]: info: ------------------------------------------- Mar 16 10:34:20 volumio volumio[3354]: info: ----- MyVolumio plugins startup ---- Mar 16 10:34:20 volumio volumio[3354]: info: ------------------------------------------- Mar 16 10:34:20 volumio volumio[3354]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 16 10:34:20 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getMyVolumioStatus Mar 16 10:34:20 volumio volumio[3354]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:20 volumio volumio[3354]: assert.ok(self.idling) Mar 16 10:34:20 volumio volumio[3354]: error: The expression evaluated to a falsy value: Mar 16 10:34:20 volumio volumio[3354]: assert.ok(self.idling) Mar 16 10:34:20 volumio volumio[3354]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:20 volumio volumio[3354]: assert.ok(self.idling) Mar 16 10:34:20 volumio volumio[3354]: error: The expression evaluated to a falsy value: Mar 16 10:34:20 volumio volumio[3354]: assert.ok(self.idling) Mar 16 10:34:20 volumio volumio[3354]: info: MPD running with PID3556 Mar 16 10:34:20 volumio volumio[3354]: ,establishing connection Mar 16 10:34:20 volumio volumio[3354]: error: updateQueue error: null Mar 16 10:34:20 volumio volumio[3354]: error: updateQueue error: null Mar 16 10:34:20 volumio volumio[3354]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:20 volumio volumio[3354]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Mar 16 10:34:20 volumio volumio[3354]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:20 volumio volumio[3354]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 16 10:34:20 volumio volumio[3354]: info: camilladsp service started and running in background, instance 1 Mar 16 10:34:20 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:20 volumio volumio[3354]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:20 volumio volumio[3354]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 16 10:34:20 volumio volumio[3354]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp loaded Mar 16 10:34:20 volumio volumio[3354]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:20 volumio sudo[3572]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 16 10:34:20 volumio sudo[3572]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 16 10:34:20 volumio volumio[3354]: info: Adding Signal Path Element [object Object] Mar 16 10:34:20 volumio volumio[3354]: info: Adding fusiondspeq DSP Signal Path Element Mar 16 10:34:20 volumio volumio[3354]: info: FusionDsp - ---- installed callbackRead Mar 16 10:34:20 volumio volumio[3354]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:20 volumio sudo[3572]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:20 volumio volumio[3354]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 16 10:34:20 volumio volumio[3354]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 16 10:34:20 volumio volumio[3354]: at onErrorNT (internal/child_process.js:465:16) Mar 16 10:34:20 volumio volumio[3354]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Mar 16 10:34:20 volumio volumio[3354]: errno: -2, Mar 16 10:34:20 volumio volumio[3354]: code: 'ENOENT', Mar 16 10:34:20 volumio volumio[3354]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:20 volumio volumio[3354]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:20 volumio volumio[3354]: spawnargs: [ Mar 16 10:34:20 volumio volumio[3354]: '-p', Mar 16 10:34:20 volumio volumio[3354]: 9876, Mar 16 10:34:20 volumio volumio[3354]: '-o', Mar 16 10:34:20 volumio volumio[3354]: '/tmp/camilladsp.log', Mar 16 10:34:20 volumio volumio[3354]: '-l', Mar 16 10:34:20 volumio volumio[3354]: 'warn', Mar 16 10:34:20 volumio volumio[3354]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 16 10:34:20 volumio volumio[3354]: ] Mar 16 10:34:20 volumio volumio[3354]: } Mar 16 10:34:20 volumio volumio[3354]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:21 volumio sudo[3583]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 10:33 Mar 16 10:34:21 volumio sudo[3583]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:21 volumio sudo[3583]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:21 volumio volumio-remote-updater[509]: [2025-03-16 10:34:21] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 16 10:34:21 volumio volumio-remote-updater[509]: [2025-03-16 10:34:21] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 16 10:34:21 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 16 10:34:21 volumio ntfs-3g[3415]: Unmounting /dev/sda1 (Music) Mar 16 10:34:21 volumio sudo[3530]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:21 volumio systemd[2879]: media-Music.mount: Succeeded. Mar 16 10:34:21 volumio sudo[3535]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:21 volumio systemd[1]: media-Music.mount: Succeeded. Mar 16 10:34:21 volumio sudo[3553]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:21 volumio sudo[3532]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:21 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 16 10:34:21 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:21 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:21 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 16 10:34:21 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 11. Mar 16 10:34:21 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:21 volumio systemd[1]: Stopped Volumio Backend Module. Mar 16 10:34:21 volumio systemd[1]: Started Volumio Backend Module. Mar 16 10:34:21 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:22 volumio volumio[3595]: info: ------------------------------------------- Mar 16 10:34:22 volumio volumio[3595]: info: ----- Volumio3 ---- Mar 16 10:34:22 volumio volumio[3595]: info: ------------------------------------------- Mar 16 10:34:22 volumio volumio[3595]: info: ----- System startup ---- Mar 16 10:34:22 volumio volumio[3595]: info: ------------------------------------------- Mar 16 10:34:22 volumio volumio[3595]: info: MYVOLUMIO Environment detected Mar 16 10:34:22 volumio volumio[3595]: info: Plugin folders cleanup Mar 16 10:34:22 volumio volumio[3595]: info: Scanning into folder /volumio/app/plugins/ Mar 16 10:34:22 volumio volumio[3595]: info: Scanning category audio_interface Mar 16 10:34:22 volumio volumio[3595]: info: Scanning category miscellanea Mar 16 10:34:22 volumio volumio[3595]: info: Scanning category music_service Mar 16 10:34:22 volumio volumio[3595]: info: Scanning category plugins.json Mar 16 10:34:22 volumio volumio[3595]: info: Scanning category system_controller Mar 16 10:34:22 volumio volumio[3595]: info: Scanning category user_interface Mar 16 10:34:22 volumio volumio[3595]: info: Scanning into folder /data/plugins/ Mar 16 10:34:22 volumio volumio[3595]: info: Scanning category audio_interface Mar 16 10:34:22 volumio volumio[3595]: info: Plugin folders cleanup completed Mar 16 10:34:22 volumio volumio[3595]: info: ------------------------------------------- Mar 16 10:34:22 volumio volumio[3595]: info: ----- Core plugins startup ---- Mar 16 10:34:22 volumio volumio[3595]: info: ------------------------------------------- Mar 16 10:34:22 volumio volumio[3595]: info: Loading plugins from folder /volumio/app/plugins/ Mar 16 10:34:22 volumio volumio[3595]: info: Adding plugin upnp to MyMusic Plugins Mar 16 10:34:22 volumio volumio[3595]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 16 10:34:22 volumio volumio[3595]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 16 10:34:22 volumio volumio[3595]: info: Loading plugins from folder /data/plugins/ Mar 16 10:34:22 volumio volumio[3595]: info: Loading plugin "system"... Mar 16 10:34:22 volumio volumio[3595]: info: Loading plugin "appearance"... Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "network"... Mar 16 10:34:23 volumio volumio[3595]: info: Refreshing Cached IP Addresses Mar 16 10:34:23 volumio sudo[3624]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 16 10:34:23 volumio sudo[3624]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:23 volumio sudo[3624]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:23 volumio sudo[3626]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 16 10:34:23 volumio sudo[3626]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:23 volumio sudo[3626]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "services"... Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "alsa_controller"... Mar 16 10:34:23 volumio sudo[3635]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 16 10:34:23 volumio sudo[3635]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:23 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "wizard"... Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "networkfs"... Mar 16 10:34:23 volumio volumio[3595]: info: Starting Udev Watcher for removable devices Mar 16 10:34:23 volumio volumio[3595]: info: Ignoring mount for partition: boot Mar 16 10:34:23 volumio volumio[3595]: info: Ignoring mount for partition: volumio Mar 16 10:34:23 volumio volumio[3595]: info: Ignoring mount for partition: volumio_data Mar 16 10:34:23 volumio volumio[3595]: info: Mounting Device Music Mar 16 10:34:23 volumio sudo[3655]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:23 volumio sudo[3655]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:23 volumio ntfs-3g[3658]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 16 10:34:23 volumio ntfs-3g[3658]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Mar 16 10:34:23 volumio ntfs-3g[3658]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:23 volumio ntfs-3g[3658]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 16 10:34:23 volumio ntfs-3g[3658]: Global ownership and permissions enforced, configuration type 7 Mar 16 10:34:23 volumio sudo[3655]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:23 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "volumio_command_line_client"... Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "upnp"... Mar 16 10:34:23 volumio volumio[3595]: info: [1742121263776] Starting Upmpd Daemon Mar 16 10:34:23 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "my_music"... Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "mpd"... Mar 16 10:34:23 volumio volumio[3595]: info: Loading plugin "upnp_browser"... Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "alarm-clock"... Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "airplay_emulation"... Mar 16 10:34:24 volumio volumio[3595]: info: Starting Shairport Sync Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "last_100"... Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "webradio"... Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "i2s_dacs"... Mar 16 10:34:24 volumio volumio[3595]: info: I2S DAC not set, start Auto-detection Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "volumiodiscovery"... Mar 16 10:34:24 volumio volumio[3595]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:24 volumio volumio[3595]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:24 volumio node[3595]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:24 volumio volumio[3595]: *** WARNING *** For more information see Mar 16 10:34:24 volumio volumio[3595]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:24 volumio volumio[3595]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:24 volumio volumio[3595]: *** WARNING *** For more information see Mar 16 10:34:24 volumio node[3595]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:24 volumio node[3595]: *** WARNING *** For more information see Mar 16 10:34:24 volumio node[3595]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:24 volumio node[3595]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:24 volumio node[3595]: *** WARNING *** For more information see Mar 16 10:34:24 volumio volumio[3595]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 16 10:34:24 volumio volumio[3595]: info: Discovery: Started advertising with name: Volumio Mar 16 10:34:24 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "outputs"... Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "albumart"... Mar 16 10:34:24 volumio volumio[3595]: info: Plugin example_plugin is not enabled Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "inputs"... Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "updater_comm"... Mar 16 10:34:24 volumio volumio[3595]: info: Plugin mpdemulation is not enabled Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "rest_api"... Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "websocket"... Mar 16 10:34:24 volumio volumio[3595]: info: Starting Socket.io Server version 2.3.0 Mar 16 10:34:24 volumio volumio[3595]: info: Loading plugin "fusiondsp"... Mar 16 10:34:24 volumio volumio[3595]: Forking 3 albumart workers Mar 16 10:34:24 volumio volumio[3595]: info: Applying required configuration parameters for plugin fusiondsp Mar 16 10:34:24 volumio volumio[3595]: info: Loading i18n strings for locale pl Mar 16 10:34:24 volumio volumio[3595]: Updating browse sources language Mar 16 10:34:24 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::initPlayerControls Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: Express server listening on port 3000 Mar 16 10:34:25 volumio volumio[3595]: [Metrics] WebUI: 3s 43.40ms Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::resetVolumioState Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::getcurrentVolume Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: Starting albumart workers Mar 16 10:34:25 volumio volumio[3595]: info: Volumio Network Manager: Network status updated: 2 Mar 16 10:34:25 volumio volumio[3595]: Starting albumart workers Mar 16 10:34:25 volumio volumio[3595]: Starting albumart workers Mar 16 10:34:25 volumio volumio[3595]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::setRepeat null single undefined Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::pushState Mar 16 10:34:25 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::setRandom null Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::pushState Mar 16 10:34:25 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:25 volumio volumio[3595]: info: Setting Device type: Raspberry PI Mar 16 10:34:25 volumio volumio[3595]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::pushState Mar 16 10:34:25 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::updateTrackBlock Mar 16 10:34:25 volumio volumio[3595]: info: CorePlayQueue::getTrackBlock Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:25 volumio volumio[3595]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 16 10:34:25 volumio volumio[3595]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 16 10:34:25 volumio volumio[3595]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 16 10:34:25 volumio volumio[3595]: info: Completed loading Core Plugins Mar 16 10:34:25 volumio volumio[3595]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:25 volumio volumio[3595]: info: Discovery: adding daf3d5df-fe0e-4e5d-8bee-1bbabba64c0f Mar 16 10:34:25 volumio volumio[3595]: info: Discovery: Found device Volumio Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:25 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:25 volumio volumio[3595]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:25 volumio volumio[3595]: info: Reading ALSA contributions from plugins. Mar 16 10:34:25 volumio volumio[3595]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:25 volumio volumio[3595]: info: CoreStateMachine::pushState Mar 16 10:34:25 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:25 volumio volumio[3595]: info: Reloading queue from file Mar 16 10:34:25 volumio volumio[3595]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:25 volumio volumio[3595]: info: Output device has changed, restarting MPD Mar 16 10:34:25 volumio volumio[3595]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:25 volumio sudo[3726]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:25 volumio sudo[3726]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:25 volumio sudo[3726]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:25 volumio sudo[3728]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:25 volumio sudo[3728]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:25 volumio systemd[1]: Stopping Music Player Daemon... Mar 16 10:34:25 volumio volumio[3595]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:25 volumio volumio[3595]: info: ___________ START PLUGINS ___________ Mar 16 10:34:25 volumio volumio[3595]: info: ControllerMpd::onStart: Initializing MPD Mar 16 10:34:25 volumio volumio[3595]: info: Creating MPD Configuration file Mar 16 10:34:25 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:25 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:25 volumio sudo[3736]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:25 volumio sudo[3736]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:25 volumio volumio[3595]: info: [1742121265935] CoreMusicLibrary::Adding element Serwery Mediów Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:25 volumio sudo[3736]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:25 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:25 volumio sudo[3738]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:25 volumio sudo[3738]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:25 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 16 10:34:25 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:25 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:25 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:25 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:26 volumio sudo[3741]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:26 volumio sudo[3741]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio sudo[3741]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:26 volumio volumio[3595]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:26 volumio volumio[3595]: info: [1742121266063] CoreMusicLibrary::Adding element Last_100 Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:26 volumio volumio[3595]: info: [1742121266066] CoreMusicLibrary::Adding element Webradio Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:26 volumio volumio[3595]: info: Initializing BBC Radios Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: Loading i18n strings for locale pl Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: FusionDsp - mixtype--------------------- Hardware Mar 16 10:34:26 volumio volumio[3595]: info: Volumio Calling Home Mar 16 10:34:26 volumio volumio[3595]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:26 volumio volumio[3595]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:26 volumio volumio[3595]: info: Reading ALSA contributions from plugins. Mar 16 10:34:26 volumio volumio[3595]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 2 Mar 16 10:34:26 volumio volumio[3595]: info: MPD Permissions set Mar 16 10:34:26 volumio volumio[3595]: info: MPD Permissions set Mar 16 10:34:26 volumio volumio[3595]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio-remote-updater[509]: [2025-03-16 10:34:26] [connect] Successful connection Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio-remote-updater[509]: [2025-03-16 10:34:26] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742121266 101 Mar 16 10:34:26 volumio volumio[3595]: 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: 4 Mar 16 10:34:26 volumio volumio[3595]: info: Starting Shairport Sync Mar 16 10:34:26 volumio volumio[3595]: info: Starting Shairport Sync Mar 16 10:34:26 volumio sudo[3773]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:26 volumio volumio[3595]: info: Starting Shairport Sync Mar 16 10:34:26 volumio sudo[3773]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio sudo[3775]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:26 volumio sudo[3775]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:26 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:26 volumio sudo[3778]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:26 volumio sudo[3778]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 16 10:34:26 volumio volumio[3595]: info: Volumio called home Mar 16 10:34:26 volumio volumio[3595]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:26 volumio volumio[3595]: info: Output device has changed, restarting MPD Mar 16 10:34:26 volumio volumio[3595]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:26 volumio sudo[3782]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:26 volumio sudo[3782]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio sudo[3782]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:26 volumio sudo[3784]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:26 volumio sudo[3784]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:26 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:26 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:26 volumio volumio[3595]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:26 volumio volumio[3595]: info: MPD Permissions set Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:26 volumio volumio[3595]: info: Starting Shairport Sync Mar 16 10:34:26 volumio sudo[3796]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:26 volumio sudo[3796]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio sudo[3790]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:26 volumio sudo[3790]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:26 volumio sudo[3790]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioGetVisibleSources Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:26 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:26 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 16 10:34:26 volumio volumio[3595]: info: Received Get System Info Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 10:34:26 volumio volumio[3595]: info: Discovery: Getting this device information Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:26 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:26 volumio volumio[3595]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:26 volumio volumio[3595]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:26 volumio volumio[3595]: info: Listing playlists Mar 16 10:34:27 volumio sudo[3635]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:27 volumio volumio[3595]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:27 volumio volumio[3595]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:27 volumio volumio[3595]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:27 volumio volumio[3595]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:27 volumio volumio[3595]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:27 volumio volumio[3595]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - Mar 16 10:34:27 volumio mpd[3799]: Mar 16 10:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 16 10:34:27 volumio systemd[1]: Started Music Player Daemon. Mar 16 10:34:27 volumio sudo[3738]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:27 volumio sudo[3784]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:27 volumio sudo[3728]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - undefined Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - undefined Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - undefined Mar 16 10:34:27 volumio volumio[3595]: info: FusionDsp - undefined Mar 16 10:34:28 volumio volumio[3595]: info: FusionDsp - undefined Mar 16 10:34:28 volumio volumio[3595]: info: Completed starting Core Plugins Mar 16 10:34:28 volumio volumio[3595]: info: ------------------------------------------- Mar 16 10:34:28 volumio volumio[3595]: info: ----- MyVolumio plugins startup ---- Mar 16 10:34:28 volumio volumio[3595]: info: ------------------------------------------- Mar 16 10:34:28 volumio volumio[3595]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 16 10:34:28 volumio volumio[3595]: info: FusionDsp - undefined Mar 16 10:34:28 volumio volumio[3595]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:28 volumio volumio[3595]: assert.ok(self.idling) Mar 16 10:34:28 volumio volumio[3595]: error: The expression evaluated to a falsy value: Mar 16 10:34:28 volumio volumio[3595]: assert.ok(self.idling) Mar 16 10:34:28 volumio volumio[3595]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:28 volumio volumio[3595]: assert.ok(self.idling) Mar 16 10:34:28 volumio volumio[3595]: error: The expression evaluated to a falsy value: Mar 16 10:34:28 volumio volumio[3595]: assert.ok(self.idling) Mar 16 10:34:28 volumio volumio[3595]: info: MPD running with PID3799 Mar 16 10:34:28 volumio volumio[3595]: ,establishing connection Mar 16 10:34:28 volumio volumio[3595]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:28 volumio volumio[3595]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Mar 16 10:34:28 volumio volumio[3595]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:28 volumio volumio[3595]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 16 10:34:28 volumio volumio[3595]: info: camilladsp service started and running in background, instance 1 Mar 16 10:34:28 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:28 volumio volumio[3595]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:28 volumio volumio[3595]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 16 10:34:28 volumio volumio[3595]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:28 volumio volumio[3595]: info: FusionDsp loaded Mar 16 10:34:28 volumio volumio[3595]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:28 volumio sudo[3815]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 16 10:34:28 volumio sudo[3815]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:28 volumio volumio[3595]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 16 10:34:28 volumio volumio[3595]: info: Adding Signal Path Element [object Object] Mar 16 10:34:28 volumio volumio[3595]: info: Adding fusiondspeq DSP Signal Path Element Mar 16 10:34:28 volumio volumio[3595]: info: FusionDsp - ---- installed callbackRead Mar 16 10:34:28 volumio volumio[3595]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:28 volumio sudo[3815]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:28 volumio volumio[3595]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 16 10:34:28 volumio volumio[3595]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 16 10:34:28 volumio volumio[3595]: at onErrorNT (internal/child_process.js:465:16) Mar 16 10:34:28 volumio volumio[3595]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 16 10:34:28 volumio volumio[3595]: at runNextTicks (internal/process/task_queues.js:62:3) Mar 16 10:34:28 volumio volumio[3595]: at listOnTimeout (internal/timers.js:523:9) Mar 16 10:34:28 volumio volumio[3595]: at processTimers (internal/timers.js:497:7) { Mar 16 10:34:28 volumio volumio[3595]: errno: -2, Mar 16 10:34:28 volumio volumio[3595]: code: 'ENOENT', Mar 16 10:34:28 volumio volumio[3595]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:28 volumio volumio[3595]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:28 volumio volumio[3595]: spawnargs: [ Mar 16 10:34:28 volumio volumio[3595]: '-p', Mar 16 10:34:28 volumio volumio[3595]: 9876, Mar 16 10:34:28 volumio volumio[3595]: '-o', Mar 16 10:34:28 volumio volumio[3595]: '/tmp/camilladsp.log', Mar 16 10:34:28 volumio volumio[3595]: '-l', Mar 16 10:34:28 volumio volumio[3595]: 'warn', Mar 16 10:34:28 volumio volumio[3595]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 16 10:34:28 volumio volumio[3595]: ] Mar 16 10:34:28 volumio volumio[3595]: } Mar 16 10:34:28 volumio volumio[3595]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:28 volumio sudo[3826]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 10:33 Mar 16 10:34:28 volumio sudo[3826]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:28 volumio sudo[3826]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:28 volumio volumio-remote-updater[509]: [2025-03-16 10:34:28] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 16 10:34:28 volumio volumio-remote-updater[509]: [2025-03-16 10:34:28] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 16 10:34:28 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 16 10:34:28 volumio ntfs-3g[3658]: Unmounting /dev/sda1 (Music) Mar 16 10:34:28 volumio sudo[3773]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:28 volumio sudo[3778]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:28 volumio sudo[3775]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:28 volumio systemd[2879]: media-Music.mount: Succeeded. Mar 16 10:34:28 volumio systemd[1]: media-Music.mount: Succeeded. Mar 16 10:34:28 volumio sudo[3796]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:28 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 16 10:34:28 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:28 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:28 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 16 10:34:28 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 12. Mar 16 10:34:28 volumio systemd[1]: Stopped Volumio Backend Module. Mar 16 10:34:28 volumio systemd[1]: Started Volumio Backend Module. Mar 16 10:34:28 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:29 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:29 volumio volumio[3837]: info: ------------------------------------------- Mar 16 10:34:29 volumio volumio[3837]: info: ----- Volumio3 ---- Mar 16 10:34:29 volumio volumio[3837]: info: ------------------------------------------- Mar 16 10:34:29 volumio volumio[3837]: info: ----- System startup ---- Mar 16 10:34:29 volumio volumio[3837]: info: ------------------------------------------- Mar 16 10:34:30 volumio volumio[3837]: info: MYVOLUMIO Environment detected Mar 16 10:34:30 volumio volumio[3837]: info: Plugin folders cleanup Mar 16 10:34:30 volumio volumio[3837]: info: Scanning into folder /volumio/app/plugins/ Mar 16 10:34:30 volumio volumio[3837]: info: Scanning category audio_interface Mar 16 10:34:30 volumio volumio[3837]: info: Scanning category miscellanea Mar 16 10:34:30 volumio volumio[3837]: info: Scanning category music_service Mar 16 10:34:30 volumio volumio[3837]: info: Scanning category plugins.json Mar 16 10:34:30 volumio volumio[3837]: info: Scanning category system_controller Mar 16 10:34:30 volumio volumio[3837]: info: Scanning category user_interface Mar 16 10:34:30 volumio volumio[3837]: info: Scanning into folder /data/plugins/ Mar 16 10:34:30 volumio volumio[3837]: info: Scanning category audio_interface Mar 16 10:34:30 volumio volumio[3837]: info: Plugin folders cleanup completed Mar 16 10:34:30 volumio volumio[3837]: info: ------------------------------------------- Mar 16 10:34:30 volumio volumio[3837]: info: ----- Core plugins startup ---- Mar 16 10:34:30 volumio volumio[3837]: info: ------------------------------------------- Mar 16 10:34:30 volumio volumio[3837]: info: Loading plugins from folder /volumio/app/plugins/ Mar 16 10:34:30 volumio volumio[3837]: info: Adding plugin upnp to MyMusic Plugins Mar 16 10:34:30 volumio volumio[3837]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 16 10:34:30 volumio volumio[3837]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 16 10:34:30 volumio volumio[3837]: info: Loading plugins from folder /data/plugins/ Mar 16 10:34:30 volumio volumio[3837]: info: Loading plugin "system"... Mar 16 10:34:30 volumio volumio[3837]: info: Loading plugin "appearance"... Mar 16 10:34:30 volumio volumio[3837]: info: Loading plugin "network"... Mar 16 10:34:30 volumio volumio[3837]: info: Refreshing Cached IP Addresses Mar 16 10:34:30 volumio sudo[3864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 16 10:34:30 volumio sudo[3864]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:30 volumio sudo[3864]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:31 volumio sudo[3866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 16 10:34:31 volumio sudo[3866]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:31 volumio sudo[3866]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "services"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "alsa_controller"... Mar 16 10:34:31 volumio sudo[3875]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 16 10:34:31 volumio sudo[3875]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:31 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "wizard"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "networkfs"... Mar 16 10:34:31 volumio volumio[3837]: info: Starting Udev Watcher for removable devices Mar 16 10:34:31 volumio volumio[3837]: info: Ignoring mount for partition: boot Mar 16 10:34:31 volumio volumio[3837]: info: Ignoring mount for partition: volumio Mar 16 10:34:31 volumio volumio[3837]: info: Ignoring mount for partition: volumio_data Mar 16 10:34:31 volumio volumio[3837]: info: Mounting Device Music Mar 16 10:34:31 volumio sudo[3895]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:31 volumio sudo[3895]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:31 volumio ntfs-3g[3898]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 16 10:34:31 volumio ntfs-3g[3898]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Mar 16 10:34:31 volumio ntfs-3g[3898]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:31 volumio ntfs-3g[3898]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 16 10:34:31 volumio ntfs-3g[3898]: Global ownership and permissions enforced, configuration type 7 Mar 16 10:34:31 volumio sudo[3895]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:31 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "volumio_command_line_client"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "upnp"... Mar 16 10:34:31 volumio volumio[3837]: info: [1742121271260] Starting Upmpd Daemon Mar 16 10:34:31 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "my_music"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "mpd"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "upnp_browser"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "alarm-clock"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "airplay_emulation"... Mar 16 10:34:31 volumio volumio[3837]: info: Starting Shairport Sync Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "last_100"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "webradio"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "i2s_dacs"... Mar 16 10:34:31 volumio volumio[3837]: info: I2S DAC not set, start Auto-detection Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "volumiodiscovery"... Mar 16 10:34:31 volumio volumio[3837]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:31 volumio volumio[3837]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:31 volumio node[3837]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:31 volumio volumio[3837]: *** WARNING *** For more information see Mar 16 10:34:31 volumio volumio[3837]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:31 volumio volumio[3837]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:31 volumio volumio[3837]: *** WARNING *** For more information see Mar 16 10:34:31 volumio node[3837]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:31 volumio node[3837]: *** WARNING *** For more information see Mar 16 10:34:31 volumio node[3837]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:31 volumio node[3837]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:31 volumio node[3837]: *** WARNING *** For more information see Mar 16 10:34:31 volumio volumio[3837]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 16 10:34:31 volumio volumio[3837]: info: Discovery: Started advertising with name: Volumio Mar 16 10:34:31 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "outputs"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "albumart"... Mar 16 10:34:31 volumio volumio[3837]: info: Plugin example_plugin is not enabled Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "inputs"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "updater_comm"... Mar 16 10:34:31 volumio volumio[3837]: info: Plugin mpdemulation is not enabled Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "rest_api"... Mar 16 10:34:31 volumio volumio[3837]: info: Loading plugin "websocket"... Mar 16 10:34:32 volumio volumio[3837]: info: Starting Socket.io Server version 2.3.0 Mar 16 10:34:32 volumio volumio[3837]: info: Loading plugin "fusiondsp"... Mar 16 10:34:32 volumio volumio[3837]: Forking 3 albumart workers Mar 16 10:34:32 volumio volumio[3837]: info: Applying required configuration parameters for plugin fusiondsp Mar 16 10:34:32 volumio volumio[3837]: info: Loading i18n strings for locale pl Mar 16 10:34:32 volumio volumio[3837]: Updating browse sources language Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::initPlayerControls Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: Express server listening on port 3000 Mar 16 10:34:32 volumio volumio[3837]: [Metrics] WebUI: 2s 942.85ms Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::resetVolumioState Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::getcurrentVolume Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:32 volumio volumio[3837]: info: Volumio Network Manager: Network status updated: 2 Mar 16 10:34:32 volumio volumio[3837]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 16 10:34:32 volumio volumio[3837]: Starting albumart workers Mar 16 10:34:32 volumio volumio[3837]: Starting albumart workers Mar 16 10:34:32 volumio volumio[3837]: Starting albumart workers Mar 16 10:34:32 volumio volumio[3837]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::pushState Mar 16 10:34:32 volumio volumio[3837]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::updateTrackBlock Mar 16 10:34:32 volumio volumio[3837]: info: CorePlayQueue::getTrackBlock Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::setRepeat null single undefined Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::pushState Mar 16 10:34:32 volumio volumio[3837]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::setRandom null Mar 16 10:34:32 volumio volumio[3837]: info: CoreStateMachine::pushState Mar 16 10:34:32 volumio volumio[3837]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:32 volumio volumio[3837]: info: Setting Device type: Raspberry PI Mar 16 10:34:32 volumio volumio[3837]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 16 10:34:32 volumio volumio[3837]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 16 10:34:32 volumio volumio[3837]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 16 10:34:32 volumio volumio[3837]: info: Discovery: adding daf3d5df-fe0e-4e5d-8bee-1bbabba64c0f Mar 16 10:34:32 volumio volumio[3837]: info: Discovery: Found device Volumio Mar 16 10:34:32 volumio volumio[3837]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:32 volumio volumio[3837]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:32 volumio volumio[3837]: info: Completed loading Core Plugins Mar 16 10:34:32 volumio volumio[3837]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:32 volumio volumio[3837]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:32 volumio volumio[3837]: info: Reading ALSA contributions from plugins. Mar 16 10:34:33 volumio volumio[3837]: info: Reloading queue from file Mar 16 10:34:33 volumio volumio[3837]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:33 volumio volumio[3837]: info: CoreStateMachine::pushState Mar 16 10:34:33 volumio volumio[3837]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:33 volumio volumio[3837]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:33 volumio volumio[3837]: info: Output device has changed, restarting MPD Mar 16 10:34:33 volumio volumio[3837]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:33 volumio sudo[3942]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:33 volumio sudo[3942]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio sudo[3942]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:33 volumio sudo[3944]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:33 volumio sudo[3944]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio volumio[3837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:33 volumio volumio[3837]: info: ___________ START PLUGINS ___________ Mar 16 10:34:33 volumio volumio[3837]: info: ControllerMpd::onStart: Initializing MPD Mar 16 10:34:33 volumio volumio[3837]: info: Creating MPD Configuration file Mar 16 10:34:33 volumio systemd[1]: Stopping Music Player Daemon... Mar 16 10:34:33 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:33 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:33 volumio volumio[3837]: info: [1742121273278] CoreMusicLibrary::Adding element Serwery Mediów Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:33 volumio sudo[3964]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:33 volumio sudo[3964]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:33 volumio sudo[3970]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:33 volumio sudo[3970]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio sudo[3964]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:33 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 16 10:34:33 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:33 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:33 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:33 volumio volumio[3837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:33 volumio sudo[3977]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:33 volumio sudo[3977]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio sudo[3977]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:33 volumio volumio[3837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:33 volumio volumio[3837]: info: [1742121273422] CoreMusicLibrary::Adding element Last_100 Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:33 volumio volumio[3837]: info: [1742121273425] CoreMusicLibrary::Adding element Webradio Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:33 volumio volumio[3837]: info: Initializing BBC Radios Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: Loading i18n strings for locale pl Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: FusionDsp - mixtype--------------------- Hardware Mar 16 10:34:33 volumio volumio[3837]: info: Volumio Calling Home Mar 16 10:34:33 volumio volumio[3837]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:33 volumio volumio[3837]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:33 volumio volumio[3837]: info: Reading ALSA contributions from plugins. Mar 16 10:34:33 volumio volumio[3837]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 2 Mar 16 10:34:33 volumio volumio[3837]: info: MPD Permissions set Mar 16 10:34:33 volumio volumio[3837]: info: MPD Permissions set Mar 16 10:34:33 volumio volumio[3837]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: Starting Shairport Sync Mar 16 10:34:33 volumio volumio-remote-updater[509]: [2025-03-16 10:34:33] [connect] Successful connection Mar 16 10:34:33 volumio volumio[3837]: info: Starting Shairport Sync Mar 16 10:34:33 volumio sudo[4012]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:33 volumio volumio[3837]: info: Starting Shairport Sync Mar 16 10:34:33 volumio sudo[4012]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio sudo[4014]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:33 volumio volumio[3837]: info: Volumio called home Mar 16 10:34:33 volumio sudo[4014]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio sudo[4017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:33 volumio sudo[4017]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio volumio-remote-updater[509]: [2025-03-16 10:34:33] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742121273 101 Mar 16 10:34:33 volumio volumio[3837]: 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: 4 Mar 16 10:34:33 volumio volumio[3837]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:33 volumio volumio[3837]: info: Output device has changed, restarting MPD Mar 16 10:34:33 volumio volumio[3837]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:33 volumio sudo[4021]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:33 volumio sudo[4021]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio sudo[4021]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:33 volumio sudo[4023]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:33 volumio sudo[4023]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:33 volumio volumio[3837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:33 volumio volumio[3837]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:33 volumio volumio[3837]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:33 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:33 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:33 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:33 volumio volumio[3837]: info: MPD Permissions set Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:34 volumio volumio[3837]: info: Starting Shairport Sync Mar 16 10:34:34 volumio sudo[4035]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:34 volumio sudo[4035]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:34 volumio sudo[4029]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:34 volumio sudo[4029]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:34 volumio sudo[4029]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio sudo[3875]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio mpd[4038]: Mar 16 10:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 16 10:34:34 volumio systemd[1]: shairport-sync.service: State 'stop-sigterm' timed out. Killing. Mar 16 10:34:34 volumio systemd[1]: shairport-sync.service: Killing process 1063 (shairport-sync) with signal SIGKILL. Mar 16 10:34:34 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=9/KILL Mar 16 10:34:34 volumio systemd[1]: shairport-sync.service: Failed with result 'timeout'. Mar 16 10:34:34 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:34 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:34 volumio sudo[4035]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio sudo[4012]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio sudo[4017]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio volumio[3837]: info: Shairport-Sync Started Mar 16 10:34:34 volumio sudo[4014]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio volumio[3837]: Error adding Membership: Error: addMembership EINVAL Mar 16 10:34:34 volumio volumio[3837]: info: Shairport-Sync Started Mar 16 10:34:34 volumio volumio[3837]: info: Shairport-Sync Started Mar 16 10:34:34 volumio volumio[3837]: info: Shairport-Sync Started Mar 16 10:34:34 volumio systemd[1]: Started Music Player Daemon. Mar 16 10:34:34 volumio sudo[3944]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio sudo[4023]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio sudo[3970]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:34 volumio volumio[3837]: info: Completed starting Core Plugins Mar 16 10:34:34 volumio volumio[3837]: info: ------------------------------------------- Mar 16 10:34:34 volumio volumio[3837]: info: ----- MyVolumio plugins startup ---- Mar 16 10:34:34 volumio volumio[3837]: info: ------------------------------------------- Mar 16 10:34:34 volumio volumio[3837]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 16 10:34:34 volumio volumio[3837]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:34 volumio volumio[3837]: assert.ok(self.idling) Mar 16 10:34:34 volumio volumio[3837]: error: The expression evaluated to a falsy value: Mar 16 10:34:34 volumio volumio[3837]: assert.ok(self.idling) Mar 16 10:34:34 volumio volumio[3837]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:34:34 volumio volumio[3837]: assert.ok(self.idling) Mar 16 10:34:34 volumio volumio[3837]: error: The expression evaluated to a falsy value: Mar 16 10:34:34 volumio volumio[3837]: assert.ok(self.idling) Mar 16 10:34:34 volumio volumio[3837]: info: MPD running with PID4038 Mar 16 10:34:34 volumio volumio[3837]: ,establishing connection Mar 16 10:34:34 volumio volumio[3837]: error: updateQueue error: null Mar 16 10:34:34 volumio volumio[3837]: error: updateQueue error: null Mar 16 10:34:35 volumio volumio[3837]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:35 volumio volumio[3837]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Mar 16 10:34:35 volumio volumio[3837]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:34:35 volumio volumio[3837]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 16 10:34:35 volumio volumio[3837]: info: camilladsp service started and running in background, instance 1 Mar 16 10:34:35 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:35 volumio volumio[3837]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:35 volumio volumio[3837]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 16 10:34:35 volumio volumio[3837]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:34:35 volumio volumio[3837]: info: FusionDsp loaded Mar 16 10:34:35 volumio volumio[3837]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:35 volumio sudo[4057]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 16 10:34:35 volumio sudo[4057]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:35 volumio volumio[3837]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 16 10:34:35 volumio volumio[3837]: info: Adding Signal Path Element [object Object] Mar 16 10:34:35 volumio volumio[3837]: info: Adding fusiondspeq DSP Signal Path Element Mar 16 10:34:35 volumio volumio[3837]: info: FusionDsp - ---- installed callbackRead Mar 16 10:34:35 volumio volumio[3837]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:35 volumio sudo[4057]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:35 volumio volumio[3837]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 16 10:34:35 volumio volumio[3837]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 16 10:34:35 volumio volumio[3837]: at onErrorNT (internal/child_process.js:465:16) Mar 16 10:34:35 volumio volumio[3837]: at processTicksAndRejections (internal/process/task_queues.js:80:21) { Mar 16 10:34:35 volumio volumio[3837]: errno: -2, Mar 16 10:34:35 volumio volumio[3837]: code: 'ENOENT', Mar 16 10:34:35 volumio volumio[3837]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:35 volumio volumio[3837]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:34:35 volumio volumio[3837]: spawnargs: [ Mar 16 10:34:35 volumio volumio[3837]: '-p', Mar 16 10:34:35 volumio volumio[3837]: 9876, Mar 16 10:34:35 volumio volumio[3837]: '-o', Mar 16 10:34:35 volumio volumio[3837]: '/tmp/camilladsp.log', Mar 16 10:34:35 volumio volumio[3837]: '-l', Mar 16 10:34:35 volumio volumio[3837]: 'warn', Mar 16 10:34:35 volumio volumio[3837]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 16 10:34:35 volumio volumio[3837]: ] Mar 16 10:34:35 volumio volumio[3837]: } Mar 16 10:34:35 volumio volumio[3837]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:35 volumio sudo[4068]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 10:33 Mar 16 10:34:35 volumio sudo[4068]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:36 volumio sudo[4068]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:36 volumio volumio-remote-updater[509]: [2025-03-16 10:34:36] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 16 10:34:36 volumio volumio-remote-updater[509]: [2025-03-16 10:34:36] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 16 10:34:36 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 16 10:34:36 volumio systemd[1]: media-Music.mount: Succeeded. Mar 16 10:34:36 volumio ntfs-3g[3898]: Unmounting /dev/sda1 (Music) Mar 16 10:34:36 volumio systemd[2879]: media-Music.mount: Succeeded. Mar 16 10:34:36 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 16 10:34:36 volumio sudo[4074]: volumio : TTY=tty1 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt-get update Mar 16 10:34:36 volumio sudo[4074]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Mar 16 10:34:36 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:36 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:36 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 16 10:34:36 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 13. Mar 16 10:34:36 volumio systemd[1]: Stopped Volumio Backend Module. Mar 16 10:34:36 volumio systemd[1]: Started Volumio Backend Module. Mar 16 10:34:36 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:36 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:37 volumio volumio[4081]: info: ------------------------------------------- Mar 16 10:34:37 volumio volumio[4081]: info: ----- Volumio3 ---- Mar 16 10:34:37 volumio volumio[4081]: info: ------------------------------------------- Mar 16 10:34:37 volumio volumio[4081]: info: ----- System startup ---- Mar 16 10:34:37 volumio volumio[4081]: info: ------------------------------------------- Mar 16 10:34:37 volumio volumio[4081]: info: MYVOLUMIO Environment detected Mar 16 10:34:37 volumio volumio[4081]: info: Plugin folders cleanup Mar 16 10:34:37 volumio volumio[4081]: info: Scanning into folder /volumio/app/plugins/ Mar 16 10:34:37 volumio volumio[4081]: info: Scanning category audio_interface Mar 16 10:34:37 volumio volumio[4081]: info: Scanning category miscellanea Mar 16 10:34:37 volumio volumio[4081]: info: Scanning category music_service Mar 16 10:34:37 volumio volumio[4081]: info: Scanning category plugins.json Mar 16 10:34:37 volumio volumio[4081]: info: Scanning category system_controller Mar 16 10:34:37 volumio volumio[4081]: info: Scanning category user_interface Mar 16 10:34:37 volumio volumio[4081]: info: Scanning into folder /data/plugins/ Mar 16 10:34:37 volumio volumio[4081]: info: Scanning category audio_interface Mar 16 10:34:37 volumio volumio[4081]: info: Plugin folders cleanup completed Mar 16 10:34:37 volumio volumio[4081]: info: ------------------------------------------- Mar 16 10:34:37 volumio volumio[4081]: info: ----- Core plugins startup ---- Mar 16 10:34:37 volumio volumio[4081]: info: ------------------------------------------- Mar 16 10:34:37 volumio volumio[4081]: info: Loading plugins from folder /volumio/app/plugins/ Mar 16 10:34:37 volumio volumio[4081]: info: Adding plugin upnp to MyMusic Plugins Mar 16 10:34:37 volumio volumio[4081]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 16 10:34:37 volumio volumio[4081]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 16 10:34:37 volumio volumio[4081]: info: Loading plugins from folder /data/plugins/ Mar 16 10:34:37 volumio volumio[4081]: info: Loading plugin "system"... Mar 16 10:34:37 volumio volumio[4081]: info: Loading plugin "appearance"... Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "network"... Mar 16 10:34:38 volumio volumio[4081]: info: Refreshing Cached IP Addresses Mar 16 10:34:38 volumio sudo[4344]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 16 10:34:38 volumio sudo[4344]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:38 volumio sudo[4344]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:38 volumio sudo[4346]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 16 10:34:38 volumio sudo[4346]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:38 volumio sudo[4346]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "services"... Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "alsa_controller"... Mar 16 10:34:38 volumio sudo[4355]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 16 10:34:38 volumio sudo[4355]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:38 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "wizard"... Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "networkfs"... Mar 16 10:34:38 volumio volumio[4081]: info: Starting Udev Watcher for removable devices Mar 16 10:34:38 volumio volumio[4081]: info: Ignoring mount for partition: boot Mar 16 10:34:38 volumio volumio[4081]: info: Ignoring mount for partition: volumio Mar 16 10:34:38 volumio volumio[4081]: info: Ignoring mount for partition: volumio_data Mar 16 10:34:38 volumio volumio[4081]: info: Mounting Device Music Mar 16 10:34:38 volumio sudo[4375]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:38 volumio sudo[4375]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:38 volumio ntfs-3g[4378]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 16 10:34:38 volumio ntfs-3g[4378]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Mar 16 10:34:38 volumio ntfs-3g[4378]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:38 volumio ntfs-3g[4378]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 16 10:34:38 volumio ntfs-3g[4378]: Global ownership and permissions enforced, configuration type 7 Mar 16 10:34:38 volumio sudo[4375]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:38 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "volumio_command_line_client"... Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "upnp"... Mar 16 10:34:38 volumio volumio[4081]: info: [1742121278923] Starting Upmpd Daemon Mar 16 10:34:38 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "my_music"... Mar 16 10:34:38 volumio volumio[4081]: info: Loading plugin "mpd"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "upnp_browser"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "alarm-clock"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "airplay_emulation"... Mar 16 10:34:39 volumio volumio[4081]: info: Starting Shairport Sync Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "last_100"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "webradio"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "i2s_dacs"... Mar 16 10:34:39 volumio volumio[4081]: info: I2S DAC not set, start Auto-detection Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "volumiodiscovery"... Mar 16 10:34:39 volumio volumio[4081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:39 volumio volumio[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:39 volumio node[4081]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:39 volumio volumio[4081]: *** WARNING *** For more information see Mar 16 10:34:39 volumio volumio[4081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:39 volumio volumio[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:39 volumio volumio[4081]: *** WARNING *** For more information see Mar 16 10:34:39 volumio node[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:39 volumio node[4081]: *** WARNING *** For more information see Mar 16 10:34:39 volumio node[4081]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:39 volumio node[4081]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:39 volumio node[4081]: *** WARNING *** For more information see Mar 16 10:34:39 volumio volumio[4081]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 16 10:34:39 volumio volumio[4081]: info: Discovery: Started advertising with name: Volumio Mar 16 10:34:39 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "outputs"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "albumart"... Mar 16 10:34:39 volumio volumio[4081]: info: Plugin example_plugin is not enabled Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "inputs"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "updater_comm"... Mar 16 10:34:39 volumio volumio[4081]: info: Plugin mpdemulation is not enabled Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "rest_api"... Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "websocket"... Mar 16 10:34:39 volumio volumio[4081]: info: Starting Socket.io Server version 2.3.0 Mar 16 10:34:39 volumio volumio[4081]: info: Loading plugin "fusiondsp"... Mar 16 10:34:39 volumio volumio[4081]: Forking 3 albumart workers Mar 16 10:34:40 volumio volumio[4081]: info: Applying required configuration parameters for plugin fusiondsp Mar 16 10:34:40 volumio volumio[4081]: info: Loading i18n strings for locale pl Mar 16 10:34:40 volumio volumio[4081]: Updating browse sources language Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::initPlayerControls Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: Express server listening on port 3000 Mar 16 10:34:40 volumio volumio[4081]: [Metrics] WebUI: 3s 619.70ms Mar 16 10:34:40 volumio volumio[4081]: info: CoreStateMachine::resetVolumioState Mar 16 10:34:40 volumio volumio[4081]: info: CoreStateMachine::getcurrentVolume Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:40 volumio volumio[4081]: Starting albumart workers Mar 16 10:34:40 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:40 volumio volumio[4081]: Starting albumart workers Mar 16 10:34:40 volumio volumio[4081]: info: Volumio Network Manager: Network status updated: 2 Mar 16 10:34:40 volumio volumio[4081]: Starting albumart workers Mar 16 10:34:40 volumio volumio[4081]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 16 10:34:41 volumio volumio[4081]: info: CoreStateMachine::setRepeat null single undefined Mar 16 10:34:41 volumio volumio[4081]: info: CoreStateMachine::pushState Mar 16 10:34:41 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:41 volumio volumio[4081]: info: CoreStateMachine::setRandom null Mar 16 10:34:41 volumio volumio[4081]: info: CoreStateMachine::pushState Mar 16 10:34:41 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:41 volumio volumio[4081]: info: Setting Device type: Raspberry PI Mar 16 10:34:41 volumio volumio-remote-updater[509]: [2025-03-16 10:34:41] [connect] Successful connection Mar 16 10:34:41 volumio volumio[4081]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:41 volumio volumio[4081]: info: CoreStateMachine::pushState Mar 16 10:34:41 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:41 volumio volumio[4081]: info: CoreStateMachine::updateTrackBlock Mar 16 10:34:41 volumio volumio[4081]: info: CorePlayQueue::getTrackBlock Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:41 volumio volumio[4081]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 16 10:34:41 volumio volumio[4081]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 16 10:34:41 volumio volumio[4081]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 16 10:34:41 volumio volumio-remote-updater[509]: [2025-03-16 10:34:41] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742121281 101 Mar 16 10:34:41 volumio volumio[4081]: 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: 2 Mar 16 10:34:41 volumio volumio[4081]: info: Discovery: adding daf3d5df-fe0e-4e5d-8bee-1bbabba64c0f Mar 16 10:34:41 volumio volumio[4081]: info: Discovery: Found device Volumio Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:41 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:41 volumio sudo[4074]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:41 volumio volumio[4081]: info: Reloading queue from file Mar 16 10:34:41 volumio volumio[4081]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:41 volumio volumio[4081]: info: CoreStateMachine::pushState Mar 16 10:34:41 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:41 volumio volumio[4081]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:42 volumio sudo[4355]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:43 volumio volumio[4081]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 3 Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::volumioGetVisibleSources Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:43 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:43 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 16 10:34:43 volumio volumio[4081]: info: Received Get System Info Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 10:34:43 volumio volumio[4081]: info: Discovery: Getting this device information Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:43 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:34:43 volumio volumio[4081]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:43 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:43 volumio volumio[4081]: info: Listing playlists Mar 16 10:34:44 volumio volumio[4081]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:44 volumio volumio[4081]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:44 volumio volumio[4081]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:44 volumio volumio[4081]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:44 volumio volumio[4081]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:44 volumio volumio[4081]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:44 volumio volumio[4081]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - undefined Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - undefined Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - undefined Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - undefined Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - undefined Mar 16 10:34:44 volumio volumio[4081]: info: FusionDsp - undefined Mar 16 10:34:45 volumio volumio[4081]: info: FusionDsp - undefined Mar 16 10:34:47 volumio volumio[4081]: info: Completed loading Core Plugins Mar 16 10:34:47 volumio volumio[4081]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:47 volumio volumio[4081]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:47 volumio volumio[4081]: info: Reading ALSA contributions from plugins. Mar 16 10:34:47 volumio volumio[4081]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:47 volumio volumio[4081]: info: Output device has changed, restarting MPD Mar 16 10:34:47 volumio sudo[4450]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:47 volumio sudo[4450]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio volumio[4081]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:47 volumio sudo[4453]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:47 volumio sudo[4453]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio systemd[1]: Stopping Music Player Daemon... Mar 16 10:34:47 volumio volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:47 volumio volumio[4081]: info: ___________ START PLUGINS ___________ Mar 16 10:34:47 volumio volumio[4081]: info: ControllerMpd::onStart: Initializing MPD Mar 16 10:34:47 volumio volumio[4081]: info: Creating MPD Configuration file Mar 16 10:34:47 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:47 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:47 volumio sudo[4460]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:47 volumio sudo[4460]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:47 volumio volumio[4081]: info: [1742121287368] CoreMusicLibrary::Adding element Serwery Mediów Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:47 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:47 volumio sudo[4463]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:47 volumio sudo[4463]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 16 10:34:47 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:47 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:47 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:47 volumio volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:47 volumio volumio[4081]: info: [1742121287473] CoreMusicLibrary::Adding element Last_100 Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:47 volumio volumio[4081]: info: [1742121287475] CoreMusicLibrary::Adding element Webradio Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:47 volumio sudo[4469]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:47 volumio volumio[4081]: info: Initializing BBC Radios Mar 16 10:34:47 volumio sudo[4469]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio sudo[4469]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: Loading i18n strings for locale pl Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: FusionDsp - mixtype--------------------- Hardware Mar 16 10:34:47 volumio volumio[4081]: info: Volumio Calling Home Mar 16 10:34:47 volumio volumio[4081]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:47 volumio volumio[4081]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:47 volumio volumio[4081]: info: Reading ALSA contributions from plugins. Mar 16 10:34:47 volumio volumio[4081]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 16 10:34:47 volumio volumio[4081]: info: Volumio called home Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:47 volumio volumio[4081]: info: Starting Shairport Sync Mar 16 10:34:47 volumio sudo[4496]: volumio : TTY=tty1 ; PWD=/home/volumio ; USER=root ; COMMAND=/usr/bin/apt-get upgrade Mar 16 10:34:47 volumio sudo[4496]: pam_unix(sudo:session): session opened for user root by volumio(uid=0) Mar 16 10:34:47 volumio volumio[4081]: info: Starting Shairport Sync Mar 16 10:34:47 volumio sudo[4500]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:47 volumio sudo[4500]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio volumio[4081]: info: Starting Shairport Sync Mar 16 10:34:47 volumio sudo[4503]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:47 volumio sudo[4503]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 16 10:34:47 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 16 10:34:47 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:47 volumio volumio[4081]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:47 volumio volumio[4081]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:47 volumio sudo[4506]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:47 volumio volumio[4081]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:47 volumio volumio[4081]: info: Output device has changed, restarting MPD Mar 16 10:34:47 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:47 volumio sudo[4506]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:47 volumio sudo[4500]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:48 volumio sudo[4510]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 16 10:34:48 volumio sudo[4510]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:48 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:48 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 16 10:34:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:48 volumio volumio[4081]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:48 volumio sudo[4503]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:48 volumio sudo[4514]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:48 volumio sudo[4514]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:48 volumio sudo[4506]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:48 volumio volumio[4081]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:48 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:48 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:48 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:48 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:48 volumio volumio[4081]: info: Shairport-Sync Started Mar 16 10:34:48 volumio volumio[4081]: Error adding Membership: Error: addMembership EINVAL Mar 16 10:34:48 volumio volumio[4081]: info: Shairport-Sync Started Mar 16 10:34:48 volumio volumio[4081]: info: Shairport-Sync Started Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:48 volumio volumio[4081]: info: Starting Shairport Sync Mar 16 10:34:48 volumio sudo[4521]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:48 volumio sudo[4521]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:48 volumio sudo[4521]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:48 volumio sudo[4527]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:48 volumio sudo[4527]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:48 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 16 10:34:48 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 16 10:34:48 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:48 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:48 volumio sudo[4527]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:48 volumio volumio[4081]: info: Shairport-Sync Started Mar 16 10:34:53 volumio sudo[4450]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:53 volumio sudo[4460]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:53 volumio mpd[4529]: Mar 16 10:34 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 16 10:34:53 volumio volumio[4081]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:53 volumio volumio[4081]: TypeError: Cannot read property 'off' of undefined Mar 16 10:34:53 volumio volumio[4081]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Mar 16 10:34:53 volumio volumio[4081]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Mar 16 10:34:53 volumio volumio[4081]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Mar 16 10:34:53 volumio volumio[4081]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1556:29) Mar 16 10:34:53 volumio volumio[4081]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1401:47) Mar 16 10:34:53 volumio volumio[4081]: at Socket.emit (events.js:315:20) Mar 16 10:34:53 volumio volumio[4081]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Mar 16 10:34:53 volumio volumio[4081]: at processTicksAndRejections (internal/process/task_queues.js:75:11) Mar 16 10:34:53 volumio volumio[4081]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:34:53 volumio systemd[1]: Started Music Player Daemon. Mar 16 10:34:53 volumio sudo[4453]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:53 volumio sudo[4514]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:53 volumio sudo[4463]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:53 volumio sudo[4560]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 10:33 Mar 16 10:34:53 volumio sudo[4560]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:53 volumio sudo[4560]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:53 volumio sudo[4510]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:54 volumio volumio-remote-updater[509]: [2025-03-16 10:34:54] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Mar 16 10:34:54 volumio volumio-remote-updater[509]: [2025-03-16 10:34:54] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Mar 16 10:34:54 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Mar 16 10:34:54 volumio ntfs-3g[4378]: Unmounting /dev/sda1 (Music) Mar 16 10:34:54 volumio systemd[2879]: media-Music.mount: Succeeded. Mar 16 10:34:54 volumio systemd[1]: media-Music.mount: Succeeded. Mar 16 10:34:54 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Mar 16 10:34:54 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:54 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:54 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Mar 16 10:34:54 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 14. Mar 16 10:34:54 volumio systemd[1]: Stopped Volumio Backend Module. Mar 16 10:34:54 volumio systemd[1]: Started Volumio Backend Module. Mar 16 10:34:54 volumio systemd[1]: Started dynamicswap service. Mar 16 10:34:54 volumio systemd[1]: dynamicswap.service: Succeeded. Mar 16 10:34:55 volumio sudo[4496]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:55 volumio volumio[4575]: info: ------------------------------------------- Mar 16 10:34:55 volumio volumio[4575]: info: ----- Volumio3 ---- Mar 16 10:34:55 volumio volumio[4575]: info: ------------------------------------------- Mar 16 10:34:55 volumio volumio[4575]: info: ----- System startup ---- Mar 16 10:34:55 volumio volumio[4575]: info: ------------------------------------------- Mar 16 10:34:56 volumio volumio[4575]: info: MYVOLUMIO Environment detected Mar 16 10:34:56 volumio volumio[4575]: info: Plugin folders cleanup Mar 16 10:34:56 volumio volumio[4575]: info: Scanning into folder /volumio/app/plugins/ Mar 16 10:34:56 volumio volumio[4575]: info: Scanning category audio_interface Mar 16 10:34:56 volumio volumio[4575]: info: Scanning category miscellanea Mar 16 10:34:56 volumio volumio[4575]: info: Scanning category music_service Mar 16 10:34:56 volumio volumio[4575]: info: Scanning category plugins.json Mar 16 10:34:56 volumio volumio[4575]: info: Scanning category system_controller Mar 16 10:34:56 volumio volumio[4575]: info: Scanning category user_interface Mar 16 10:34:56 volumio volumio[4575]: info: Scanning into folder /data/plugins/ Mar 16 10:34:56 volumio volumio[4575]: info: Scanning category audio_interface Mar 16 10:34:56 volumio volumio[4575]: info: Plugin folders cleanup completed Mar 16 10:34:56 volumio volumio[4575]: info: ------------------------------------------- Mar 16 10:34:56 volumio volumio[4575]: info: ----- Core plugins startup ---- Mar 16 10:34:56 volumio volumio[4575]: info: ------------------------------------------- Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugins from folder /volumio/app/plugins/ Mar 16 10:34:56 volumio volumio[4575]: info: Adding plugin upnp to MyMusic Plugins Mar 16 10:34:56 volumio volumio[4575]: info: Adding plugin airplay_emulation to MyMusic Plugins Mar 16 10:34:56 volumio volumio[4575]: info: Adding plugin upnp_browser to MyMusic Plugins Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugins from folder /data/plugins/ Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugin "system"... Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugin "appearance"... Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugin "network"... Mar 16 10:34:56 volumio volumio[4575]: info: Refreshing Cached IP Addresses Mar 16 10:34:56 volumio sudo[4602]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Mar 16 10:34:56 volumio sudo[4602]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:56 volumio sudo[4602]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:56 volumio sudo[4604]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Mar 16 10:34:56 volumio sudo[4604]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:56 volumio sudo[4604]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugin "services"... Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugin "alsa_controller"... Mar 16 10:34:56 volumio sudo[4613]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Mar 16 10:34:56 volumio sudo[4613]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:56 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugin "wizard"... Mar 16 10:34:56 volumio volumio[4575]: info: Loading plugin "networkfs"... Mar 16 10:34:56 volumio volumio[4575]: info: Starting Udev Watcher for removable devices Mar 16 10:34:56 volumio volumio[4575]: info: Ignoring mount for partition: boot Mar 16 10:34:56 volumio volumio[4575]: info: Ignoring mount for partition: volumio Mar 16 10:34:56 volumio volumio[4575]: info: Ignoring mount for partition: volumio_data Mar 16 10:34:56 volumio volumio[4575]: info: Mounting Device Music Mar 16 10:34:56 volumio sudo[4633]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/mount /dev/sda1 /mnt/USB/Music -o noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:56 volumio sudo[4633]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:57 volumio ntfs-3g[4636]: Version 2017.3.23AR.3 integrated FUSE 28 Mar 16 10:34:57 volumio ntfs-3g[4636]: Mounted /dev/sda1 (Read-Write, label "Music", NTFS 3.1) Mar 16 10:34:57 volumio ntfs-3g[4636]: Cmdline options: rw,noatime,dmask=0000,fmask=0000,iocharset=utf8 Mar 16 10:34:57 volumio ntfs-3g[4636]: Mount options: iocharset=utf8,allow_other,nonempty,noatime,rw,default_permissions,fsname=/dev/sda1,blkdev,blksize=4096 Mar 16 10:34:57 volumio ntfs-3g[4636]: Global ownership and permissions enforced, configuration type 7 Mar 16 10:34:57 volumio sudo[4633]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:57 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "volumio_command_line_client"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "upnp"... Mar 16 10:34:57 volumio volumio[4575]: info: [1742121297045] Starting Upmpd Daemon Mar 16 10:34:57 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "my_music"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "mpd"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "upnp_browser"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "alarm-clock"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "airplay_emulation"... Mar 16 10:34:57 volumio volumio[4575]: info: Starting Shairport Sync Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "last_100"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "webradio"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "i2s_dacs"... Mar 16 10:34:57 volumio volumio[4575]: info: I2S DAC not set, start Auto-detection Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "volumiodiscovery"... Mar 16 10:34:57 volumio volumio[4575]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:57 volumio volumio[4575]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:57 volumio node[4575]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:57 volumio volumio[4575]: *** WARNING *** For more information see Mar 16 10:34:57 volumio volumio[4575]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:57 volumio volumio[4575]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:57 volumio volumio[4575]: *** WARNING *** For more information see Mar 16 10:34:57 volumio node[4575]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:57 volumio node[4575]: *** WARNING *** For more information see Mar 16 10:34:57 volumio node[4575]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Mar 16 10:34:57 volumio node[4575]: *** WARNING *** Please fix your application to use the native API of Avahi! Mar 16 10:34:57 volumio node[4575]: *** WARNING *** For more information see Mar 16 10:34:57 volumio volumio[4575]: info: Applying required configuration parameters for plugin volumiodiscovery Mar 16 10:34:57 volumio volumio[4575]: info: Discovery: Started advertising with name: Volumio Mar 16 10:34:57 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "outputs"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "albumart"... Mar 16 10:34:57 volumio volumio[4575]: info: Plugin example_plugin is not enabled Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "inputs"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "updater_comm"... Mar 16 10:34:57 volumio volumio[4575]: info: Plugin mpdemulation is not enabled Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "rest_api"... Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "websocket"... Mar 16 10:34:57 volumio volumio[4575]: info: Starting Socket.io Server version 2.3.0 Mar 16 10:34:57 volumio volumio[4575]: info: Loading plugin "fusiondsp"... Mar 16 10:34:57 volumio volumio[4575]: Forking 3 albumart workers Mar 16 10:34:58 volumio volumio[4575]: info: Applying required configuration parameters for plugin fusiondsp Mar 16 10:34:58 volumio volumio[4575]: info: Loading i18n strings for locale pl Mar 16 10:34:58 volumio volumio[4575]: Updating browse sources language Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::initPlayerControls Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: Express server listening on port 3000 Mar 16 10:34:58 volumio volumio[4575]: [Metrics] WebUI: 3s 105.15ms Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::resetVolumioState Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::getcurrentVolume Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:58 volumio volumio[4575]: Starting albumart workers Mar 16 10:34:58 volumio volumio[4575]: info: Volumio Network Manager: Network status updated: 2 Mar 16 10:34:58 volumio volumio[4575]: Starting albumart workers Mar 16 10:34:58 volumio volumio[4575]: Starting albumart workers Mar 16 10:34:58 volumio volumio[4575]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 1 Mar 16 10:34:58 volumio volumio[4575]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 2 Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::setRepeat null single undefined Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::pushState Mar 16 10:34:58 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::setRandom null Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::pushState Mar 16 10:34:58 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:58 volumio volumio[4575]: info: Setting Device type: Raspberry PI Mar 16 10:34:58 volumio volumio[4575]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::pushState Mar 16 10:34:58 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:58 volumio volumio[4575]: info: CoreStateMachine::updateTrackBlock Mar 16 10:34:58 volumio volumio[4575]: info: CorePlayQueue::getTrackBlock Mar 16 10:34:58 volumio volumio[4575]: info: CoreCommandRouter::volumioRetrievevolume Mar 16 10:34:58 volumio volumio[4575]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 16 10:34:58 volumio volumio[4575]: info: USB Boot Capable - System SBC Revision found in cpuinfo: b03115 Mar 16 10:34:58 volumio volumio[4575]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 16 10:34:58 volumio volumio[4575]: info: Completed loading Core Plugins Mar 16 10:34:58 volumio volumio[4575]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:58 volumio volumio[4575]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:58 volumio volumio[4575]: info: Reading ALSA contributions from plugins. Mar 16 10:34:59 volumio volumio[4575]: info: Reloading queue from file Mar 16 10:34:59 volumio volumio[4575]: info: Discovery: adding daf3d5df-fe0e-4e5d-8bee-1bbabba64c0f Mar 16 10:34:59 volumio volumio[4575]: info: Discovery: Found device Volumio Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:59 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:59 volumio volumio[4575]: info: VolumeController:: Volume=86 Mute =false Mar 16 10:34:59 volumio volumio[4575]: info: CoreStateMachine::pushState Mar 16 10:34:59 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::volumioPushState Mar 16 10:34:59 volumio volumio[4575]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:59 volumio volumio[4575]: info: Output device has changed, restarting MPD Mar 16 10:34:59 volumio volumio[4575]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio sudo[4704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:59 volumio sudo[4704]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio sudo[4704]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio sudo[4706]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:59 volumio sudo[4706]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio systemd[1]: Stopping Music Player Daemon... Mar 16 10:34:59 volumio volumio[4575]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:59 volumio volumio[4575]: info: ___________ START PLUGINS ___________ Mar 16 10:34:59 volumio volumio[4575]: info: ControllerMpd::onStart: Initializing MPD Mar 16 10:34:59 volumio volumio[4575]: info: Creating MPD Configuration file Mar 16 10:34:59 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:59 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:59 volumio sudo[4714]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:59 volumio sudo[4714]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:59 volumio volumio[4575]: info: [1742121299183] CoreMusicLibrary::Adding element Serwery Mediów Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio sudo[4714]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio sudo[4716]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:59 volumio sudo[4716]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:59 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Mar 16 10:34:59 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:59 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:59 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:59 volumio volumio[4575]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio volumio-remote-updater[509]: [2025-03-16 10:34:59] [connect] Successful connection Mar 16 10:34:59 volumio volumio[4575]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:59 volumio volumio[4575]: info: [1742121299276] CoreMusicLibrary::Adding element Last_100 Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 16 10:34:59 volumio volumio[4575]: info: [1742121299278] CoreMusicLibrary::Adding element Webradio Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:59 volumio volumio[4575]: info: Initializing BBC Radios Mar 16 10:34:59 volumio sudo[4722]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:59 volumio sudo[4722]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio sudo[4722]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: Loading i18n strings for locale pl Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: FusionDsp - mixtype--------------------- Hardware Mar 16 10:34:59 volumio volumio[4575]: info: Volumio Calling Home Mar 16 10:34:59 volumio volumio[4575]: info: Preparing to generate the ALSA configuration file Mar 16 10:34:59 volumio volumio[4575]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Mar 16 10:34:59 volumio volumio[4575]: info: Reading ALSA contributions from plugins. Mar 16 10:34:59 volumio volumio[4575]: info: MPD Permissions set Mar 16 10:34:59 volumio volumio[4575]: info: MPD Permissions set Mar 16 10:34:59 volumio volumio-remote-updater[509]: [2025-03-16 10:34:59] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1742121299 101 Mar 16 10:34:59 volumio volumio[4575]: 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 Mar 16 10:34:59 volumio volumio[4575]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: Volumio called home Mar 16 10:34:59 volumio volumio[4575]: info: Starting Shairport Sync Mar 16 10:34:59 volumio volumio[4575]: info: Starting Shairport Sync Mar 16 10:34:59 volumio sudo[4750]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:59 volumio sudo[4750]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio volumio[4575]: info: Starting Shairport Sync Mar 16 10:34:59 volumio sudo[4752]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:59 volumio sudo[4752]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 16 10:34:59 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 16 10:34:59 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:59 volumio sudo[4755]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:59 volumio sudo[4755]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::volumioGetState Mar 16 10:34:59 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:34:59 volumio volumio[4575]: info: Asound.conf file unchanged, so no further update is needed Mar 16 10:34:59 volumio volumio[4575]: info: Output device has changed, restarting MPD Mar 16 10:34:59 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:59 volumio sudo[4760]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 16 10:34:59 volumio sudo[4760]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio sudo[4760]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio sudo[4750]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio volumio[4575]: info: Output device has changed, restarting Shairport Sync Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 16 10:34:59 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:59 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 16 10:34:59 volumio sudo[4763]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 16 10:34:59 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:59 volumio sudo[4763]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:59 volumio sudo[4752]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio volumio[4575]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 16 10:34:59 volumio sudo[4755]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Mar 16 10:34:59 volumio systemd[1]: mpd.service: Succeeded. Mar 16 10:34:59 volumio systemd[1]: Stopped Music Player Daemon. Mar 16 10:34:59 volumio volumio[4575]: info: MPD Permissions set Mar 16 10:34:59 volumio volumio[4575]: info: Shairport-Sync Started Mar 16 10:34:59 volumio volumio[4575]: Error adding Membership: Error: addMembership EINVAL Mar 16 10:34:59 volumio volumio[4575]: info: Shairport-Sync Started Mar 16 10:34:59 volumio systemd[1]: Starting Music Player Daemon... Mar 16 10:34:59 volumio volumio[4575]: info: Shairport-Sync Started Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:34:59 volumio volumio[4575]: info: Starting Shairport Sync Mar 16 10:34:59 volumio sudo[4777]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Mar 16 10:34:59 volumio sudo[4777]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Mar 16 10:34:59 volumio sudo[4771]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 16 10:34:59 volumio systemd[1]: shairport-sync.service: Succeeded. Mar 16 10:34:59 volumio sudo[4771]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:34:59 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:59 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Mar 16 10:34:59 volumio sudo[4771]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio sudo[4777]: pam_unix(sudo:session): session closed for user root Mar 16 10:34:59 volumio volumio[4575]: info: Shairport-Sync Started Mar 16 10:35:00 volumio sudo[4613]: pam_unix(sudo:session): session closed for user root Mar 16 10:35:00 volumio mpd[4781]: Mar 16 10:35 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 16 10:35:00 volumio systemd[1]: Started Music Player Daemon. Mar 16 10:35:00 volumio sudo[4706]: pam_unix(sudo:session): session closed for user root Mar 16 10:35:00 volumio sudo[4763]: pam_unix(sudo:session): session closed for user root Mar 16 10:35:00 volumio sudo[4716]: pam_unix(sudo:session): session closed for user root Mar 16 10:35:00 volumio volumio[4575]: info: Completed starting Core Plugins Mar 16 10:35:00 volumio volumio[4575]: info: ------------------------------------------- Mar 16 10:35:00 volumio volumio[4575]: info: ----- MyVolumio plugins startup ---- Mar 16 10:35:00 volumio volumio[4575]: info: ------------------------------------------- Mar 16 10:35:00 volumio volumio[4575]: info: [MyVolumio PluginManager] Fetching plans data.... Mar 16 10:35:00 volumio volumio[4575]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:35:00 volumio volumio[4575]: assert.ok(self.idling) Mar 16 10:35:00 volumio volumio[4575]: error: The expression evaluated to a falsy value: Mar 16 10:35:00 volumio volumio[4575]: assert.ok(self.idling) Mar 16 10:35:00 volumio volumio[4575]: error: MPD error: The expression evaluated to a falsy value: Mar 16 10:35:00 volumio volumio[4575]: assert.ok(self.idling) Mar 16 10:35:00 volumio volumio[4575]: error: The expression evaluated to a falsy value: Mar 16 10:35:00 volumio volumio[4575]: assert.ok(self.idling) Mar 16 10:35:00 volumio volumio[4575]: info: MPD running with PID4781 Mar 16 10:35:00 volumio volumio[4575]: ,establishing connection Mar 16 10:35:00 volumio volumio[4575]: error: updateQueue error: null Mar 16 10:35:00 volumio volumio[4575]: error: updateQueue error: null Mar 16 10:35:00 volumio volumio[4575]: verbose: New Socket.io Connection to 192.168.8.159 from 192.168.8.122 UA: Mozilla/5.0 (Windows NT 10.0; Win64; x64; rv:136.0) Gecko/20100101 Firefox/136.0 Engine version: 3 Transport: polling Total Clients: 5 Mar 16 10:35:00 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::volumioGetVisibleSources Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::volumioGetState Mar 16 10:35:01 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::volumioGetState Mar 16 10:35:01 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Mar 16 10:35:01 volumio volumio[4575]: info: Received Get System Info Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 16 10:35:01 volumio volumio[4575]: info: Discovery: Getting this device information Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::volumioGetState Mar 16 10:35:01 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::volumioGetState Mar 16 10:35:01 volumio volumio[4575]: info: CorePlayQueue::getTrack 0 Mar 16 10:35:01 volumio volumio[4575]: info: Listing playlists Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: info: FusionDsp - Mar 16 10:35:01 volumio volumio[4575]: info: FusionDsp - undefined Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::getUIConfigOnPlugin Mar 16 10:35:01 volumio volumio[4575]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:35:01 volumio volumio[4575]: error: FusionDsp - ----failed to create fusiondspfifo :Error: Command failed: /bin/touch /tmp/fusiondsp_stream_params.log && /bin/chmod 666 /tmp/fusiondsp_stream_params.log && /bin/touch /tmp/camilladsp.log && /bin/chmod 666 /tmp/camilladsp.log && /usr/bin/mkfifo -m 646 /tmp/fusiondspfifo Mar 16 10:35:01 volumio volumio[4575]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Mar 16 10:35:01 volumio volumio[4575]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Mar 16 10:35:01 volumio volumio[4575]: info: camilladsp service started and running in background, instance 1 Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 16 10:35:01 volumio volumio[4575]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:35:01 volumio volumio[4575]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Mar 16 10:35:01 volumio volumio[4575]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Mar 16 10:35:01 volumio volumio[4575]: info: FusionDsp loaded Mar 16 10:35:01 volumio volumio[4575]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 16 10:35:01 volumio sudo[4799]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Mar 16 10:35:01 volumio sudo[4799]: pam_unix(sudo:session): session opened for user root by (uid=0) Mar 16 10:35:01 volumio volumio[4575]: info: FusionDsp - Reporting Fusion DSP Enabled Mar 16 10:35:01 volumio volumio[4575]: info: Adding Signal Path Element [object Object] Mar 16 10:35:01 volumio volumio[4575]: info: Adding fusiondspeq DSP Signal Path Element Mar 16 10:35:01 volumio volumio[4575]: info: FusionDsp - ---- installed callbackRead Mar 16 10:35:01 volumio volumio[4575]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:35:01 volumio sudo[4799]: pam_unix(sudo:session): session closed for user root Mar 16 10:35:01 volumio volumio[4575]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Mar 16 10:35:01 volumio volumio[4575]: at Process.ChildProcess._handle.onexit (internal/child_process.js:269:19) Mar 16 10:35:01 volumio volumio[4575]: at onErrorNT (internal/child_process.js:465:16) Mar 16 10:35:01 volumio volumio[4575]: at processTicksAndRejections (internal/process/task_queues.js:80:21) Mar 16 10:35:01 volumio volumio[4575]: at runNextTicks (internal/process/task_queues.js:62:3) Mar 16 10:35:01 volumio volumio[4575]: at listOnTimeout (internal/timers.js:523:9) Mar 16 10:35:01 volumio volumio[4575]: at processTimers (internal/timers.js:497:7) { Mar 16 10:35:01 volumio volumio[4575]: errno: -2, Mar 16 10:35:01 volumio volumio[4575]: code: 'ENOENT', Mar 16 10:35:01 volumio volumio[4575]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:35:01 volumio volumio[4575]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Mar 16 10:35:01 volumio volumio[4575]: spawnargs: [ Mar 16 10:35:01 volumio volumio[4575]: '-p', Mar 16 10:35:01 volumio volumio[4575]: 9876, Mar 16 10:35:01 volumio volumio[4575]: '-o', Mar 16 10:35:01 volumio volumio[4575]: '/tmp/camilladsp.log', Mar 16 10:35:01 volumio volumio[4575]: '-l', Mar 16 10:35:01 volumio volumio[4575]: 'warn', Mar 16 10:35:01 volumio volumio[4575]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Mar 16 10:35:01 volumio volumio[4575]: ] Mar 16 10:35:01 volumio volumio[4575]: } Mar 16 10:35:01 volumio volumio[4575]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 16 10:35:01 volumio sudo[4810]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-03-16 10:34 Mar 16 10:35:01 volumio sudo[4810]: 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="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"