-- Logs begin at Fri 2025-01-17 19:14:39 CET, end at Fri 2025-01-17 19:24:31 CET. -- Jan 17 19:23:00 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 17 19:23:00 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 22. Jan 17 19:23:00 volumio systemd[1]: Started dynamicswap service. Jan 17 19:23:00 volumio systemd[1]: Stopped Volumio Backend Module. Jan 17 19:23:00 volumio systemd[1]: Started Volumio Backend Module. Jan 17 19:23:00 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:23:00 volumio volumio[7989]: info: ------------------------------------------- Jan 17 19:23:00 volumio volumio[7989]: info: ----- Volumio3 ---- Jan 17 19:23:00 volumio volumio[7989]: info: ------------------------------------------- Jan 17 19:23:00 volumio volumio[7989]: info: ----- System startup ---- Jan 17 19:23:00 volumio volumio[7989]: info: ------------------------------------------- Jan 17 19:23:00 volumio volumio[7989]: info: MYVOLUMIO Environment detected Jan 17 19:23:00 volumio volumio[7989]: info: Plugin folders cleanup Jan 17 19:23:00 volumio volumio[7989]: info: Scanning into folder /volumio/app/plugins/ Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category audio_interface Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category miscellanea Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category music_service Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category plugins.json Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category system_controller Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category user_interface Jan 17 19:23:00 volumio volumio[7989]: info: Scanning into folder /data/plugins/ Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category audio_interface Jan 17 19:23:00 volumio volumio[7989]: info: Scanning category user_interface Jan 17 19:23:00 volumio volumio[7989]: info: Plugin folders cleanup completed Jan 17 19:23:00 volumio volumio[7989]: info: ------------------------------------------- Jan 17 19:23:00 volumio volumio[7989]: info: ----- Core plugins startup ---- Jan 17 19:23:00 volumio volumio[7989]: info: ------------------------------------------- Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 19:23:00 volumio volumio[7989]: info: Adding plugin upnp to MyMusic Plugins Jan 17 19:23:00 volumio volumio[7989]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 19:23:00 volumio volumio[7989]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugins from folder /data/plugins/ Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "system"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "appearance"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "network"... Jan 17 19:23:00 volumio volumio[7989]: info: Refreshing Cached IP Addresses Jan 17 19:23:00 volumio sudo[8015]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:23:00 volumio sudo[8015]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:00 volumio sudo[8015]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:00 volumio sudo[8017]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:23:00 volumio sudo[8017]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "services"... Jan 17 19:23:00 volumio sudo[8017]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "alsa_controller"... Jan 17 19:23:00 volumio sudo[8025]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 17 19:23:00 volumio sudo[8025]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:00 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "wizard"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "networkfs"... Jan 17 19:23:00 volumio volumio[7989]: info: Starting Udev Watcher for removable devices Jan 17 19:23:00 volumio volumio[7989]: info: Ignoring mount for partition: boot Jan 17 19:23:00 volumio volumio[7989]: info: Ignoring mount for partition: volumio Jan 17 19:23:00 volumio volumio[7989]: info: Ignoring mount for partition: volumio_data Jan 17 19:23:00 volumio volumio[7989]: info: Ignoring mount for partition: Zastrzeżone_przez_system Jan 17 19:23:00 volumio volumio[7989]: info: Ignoring mount for partition: B46AA8996AA859BE Jan 17 19:23:00 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "volumio_command_line_client"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "upnp"... Jan 17 19:23:00 volumio volumio[7989]: info: [1737138180790] Starting Upmpd Daemon Jan 17 19:23:00 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "my_music"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "mpd"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "upnp_browser"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "alarm-clock"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "airplay_emulation"... Jan 17 19:23:00 volumio volumio[7989]: info: Starting Shairport Sync Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "last_100"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "webradio"... Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "i2s_dacs"... Jan 17 19:23:00 volumio volumio[7989]: info: I2S DAC not set, start Auto-detection Jan 17 19:23:00 volumio volumio[7989]: info: Loading plugin "volumiodiscovery"... Jan 17 19:23:00 volumio volumio[7989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:00 volumio volumio[7989]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:00 volumio volumio[7989]: *** WARNING *** For more information see Jan 17 19:23:00 volumio volumio[7989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:00 volumio volumio[7989]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:00 volumio volumio[7989]: *** WARNING *** For more information see Jan 17 19:23:00 volumio node[7989]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:00 volumio node[7989]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:00 volumio node[7989]: *** WARNING *** For more information see Jan 17 19:23:00 volumio node[7989]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:00 volumio node[7989]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:00 volumio node[7989]: *** WARNING *** For more information see Jan 17 19:23:00 volumio volumio[7989]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 19:23:02 volumio sudo[8025]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:04 volumio volumio-remote-updater[794]: [2025-01-17 19:23:04] [connect] Successful connection Jan 17 19:23:06 volumio volumio[7989]: info: Discovery: Started advertising with name: Volumio Jan 17 19:23:06 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:06 volumio volumio[7989]: info: Loading plugin "now_playing"... Jan 17 19:23:07 volumio volumio[7989]: info: Loading plugin "outputs"... Jan 17 19:23:07 volumio volumio[7989]: info: Loading plugin "albumart"... Jan 17 19:23:07 volumio volumio[7989]: info: Plugin example_plugin is not enabled Jan 17 19:23:07 volumio volumio[7989]: info: Loading plugin "inputs"... Jan 17 19:23:07 volumio volumio[7989]: info: Loading plugin "updater_comm"... Jan 17 19:23:07 volumio volumio[7989]: info: Plugin mpdemulation is not enabled Jan 17 19:23:07 volumio volumio[7989]: info: Loading plugin "rest_api"... Jan 17 19:23:07 volumio volumio[7989]: info: Loading plugin "websocket"... Jan 17 19:23:07 volumio volumio[7989]: info: Starting Socket.io Server version 2.3.0 Jan 17 19:23:07 volumio volumio[7989]: info: Loading plugin "fusiondsp"... Jan 17 19:23:07 volumio volumio[7989]: Forking 3 albumart workers Jan 17 19:23:07 volumio volumio[7989]: Starting albumart workers Jan 17 19:23:07 volumio volumio[7989]: Starting albumart workers Jan 17 19:23:07 volumio volumio[7989]: Starting albumart workers Jan 17 19:23:09 volumio volumio[7989]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 19:23:09 volumio volumio[7989]: info: Loading i18n strings for locale pl Jan 17 19:23:09 volumio volumio[7989]: Updating browse sources language Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::initPlayerControls Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:09 volumio volumio[7989]: Express server listening on port 3000 Jan 17 19:23:09 volumio volumio[7989]: [Metrics] WebUI: 9s 703.02ms Jan 17 19:23:09 volumio volumio[7989]: info: Setting Device type: x86 Jan 17 19:23:09 volumio volumio[7989]: info: CoreStateMachine::resetVolumioState Jan 17 19:23:09 volumio volumio[7989]: info: CoreStateMachine::getcurrentVolume Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:23:09 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:13 volumio volumio[7989]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 17 19:23:13 volumio volumio[7989]: info: Completed loading Core Plugins Jan 17 19:23:13 volumio volumio[7989]: info: Preparing to generate the ALSA configuration file Jan 17 19:23:13 volumio volumio[7989]: info: Cannot read play queue from file Jan 17 19:23:13 volumio volumio[7989]: info: Volumio Network Manager: Network status updated: 2 Jan 17 19:23:13 volumio volumio[7989]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 17 19:23:13 volumio sudo[8123]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:23:13 volumio sudo[8123]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:13 volumio sudo[8123]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:13 volumio sudo[8125]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:23:13 volumio sudo[8125]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:13 volumio sudo[8125]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio volumio[7989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:23:16 volumio volumio[7989]: info: Reading ALSA contributions from plugins. Jan 17 19:23:16 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 1 Jan 17 19:23:16 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 2 Jan 17 19:23:16 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:23:16 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 4 Jan 17 19:23:16 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 17 19:23:16 volumio volumio[7989]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::pushState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::updateTrackBlock Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrackBlock Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:23:16 volumio volumio[7989]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 17 19:23:16 volumio volumio[7989]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Jan 17 19:23:16 volumio volumio[7989]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 17 19:23:16 volumio volumio[7989]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::setRepeat null single undefined Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::pushState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::setRandom null Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::pushState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:16 volumio volumio[7989]: info: Listing playlists Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 17 19:23:16 volumio volumio[7989]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Jan 17 19:23:16 volumio volumio[7989]: info: Listing playlists Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: Listing playlists Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 17 19:23:16 volumio volumio[7989]: error: Failed callmethod call: TypeError: Cannot read property 'has' of undefined Jan 17 19:23:16 volumio volumio[7989]: info: Listing playlists Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getQueue Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:23:16 volumio volumio[7989]: info: CoreStateMachine::pushState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:16 volumio volumio[7989]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:23:16 volumio volumio[7989]: info: Output device has changed, restarting MPD Jan 17 19:23:16 volumio sudo[8136]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 17 19:23:16 volumio sudo[8136]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio sudo[8136]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio sudo[8139]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:16 volumio sudo[8139]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio volumio[7989]: info: Output device has changed, restarting Shairport Sync Jan 17 19:23:16 volumio sudo[8139]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio sudo[8142]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:16 volumio sudo[8142]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 19:23:16 volumio volumio[7989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:16 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:16 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:16 volumio volumio[7989]: info: ___________ START PLUGINS ___________ Jan 17 19:23:16 volumio volumio[7989]: info: ControllerMpd::onStart: Initializing MPD Jan 17 19:23:16 volumio volumio[7989]: info: Creating MPD Configuration file Jan 17 19:23:16 volumio sudo[8149]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:16 volumio sudo[8149]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:16 volumio volumio[7989]: info: [1737138196432] CoreMusicLibrary::Adding element Serwery Mediów Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio sudo[8149]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:16 volumio sudo[8151]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:16 volumio sudo[8151]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 17 19:23:16 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:16 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:16 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:16 volumio volumio[7989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:16 volumio volumio[7989]: info: [1737138196472] CoreMusicLibrary::Adding element Last_100 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:16 volumio volumio[7989]: info: [1737138196474] CoreMusicLibrary::Adding element Webradio Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:16 volumio sudo[8157]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:23:16 volumio sudo[8157]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio volumio[7989]: info: Initializing BBC Radios Jan 17 19:23:16 volumio sudo[8157]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: [now-playing] ConfigUpdater: config is up to date. Jan 17 19:23:16 volumio volumio[7989]: info: Loading i18n strings for locale pl Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: FusionDsp - mixtype--------------------- Hardware Jan 17 19:23:16 volumio volumio[7989]: info: Volumio Calling Home Jan 17 19:23:16 volumio volumio[7989]: info: Preparing to generate the ALSA configuration file Jan 17 19:23:16 volumio volumio[7989]: info: [now-playing] App is listening on port 4004. Jan 17 19:23:16 volumio volumio[7989]: warn: [now-playing] /data/INTERNAL/NowPlayingPlugin/My Backgrounds does not exist. MyBackgroundMonitor will not start. Jan 17 19:23:16 volumio volumio[7989]: info: Discovery: adding db590945-5fbf-4bfa-8882-0bd01dc22477 Jan 17 19:23:16 volumio volumio[7989]: info: Discovery: Found device Volumio Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:23:16 volumio volumio[7989]: info: Reading ALSA contributions from plugins. Jan 17 19:23:16 volumio volumio[7989]: info: MPD Permissions set Jan 17 19:23:16 volumio volumio[7989]: info: MPD Permissions set Jan 17 19:23:16 volumio volumio[7989]: info: Upmpdcli Daemon Started Jan 17 19:23:16 volumio volumio[7989]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 6 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: Starting Shairport Sync Jan 17 19:23:16 volumio volumio[7989]: info: Starting Shairport Sync Jan 17 19:23:16 volumio volumio[7989]: info: Starting Shairport Sync Jan 17 19:23:16 volumio sudo[8189]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:16 volumio sudo[8189]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio sudo[8191]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:16 volumio sudo[8191]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:16 volumio sudo[8195]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:16 volumio sudo[8195]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio volumio[7989]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:23:16 volumio volumio[7989]: info: Output device has changed, restarting MPD Jan 17 19:23:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:16 volumio volumio[7989]: info: Output device has changed, restarting Shairport Sync Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio sudo[8201]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:16 volumio sudo[8201]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:16 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jan 17 19:23:16 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:16 volumio sudo[8189]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:16 volumio sudo[8199]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:16 volumio sudo[8199]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio sudo[8199]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:16 volumio volumio[7989]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:16 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 19:23:16 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:16 volumio sudo[8195]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:16 volumio sudo[8191]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:16 volumio volumio[7989]: info: MPD Permissions set Jan 17 19:23:16 volumio volumio[7989]: info: Shairport-Sync Started Jan 17 19:23:16 volumio volumio[7989]: Error adding Membership: Error: addMembership EINVAL Jan 17 19:23:16 volumio volumio[7989]: info: Shairport-Sync Started Jan 17 19:23:16 volumio volumio[7989]: info: Volumio called home Jan 17 19:23:16 volumio volumio[7989]: info: Shairport-Sync Started Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:16 volumio sudo[8209]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:23:16 volumio sudo[8209]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio sudo[8209]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio volumio[7989]: info: Starting Shairport Sync Jan 17 19:23:16 volumio sudo[8220]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:16 volumio sudo[8220]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:16 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:16 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:16 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:16 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:16 volumio sudo[8220]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio volumio[7989]: info: Shairport-Sync Started Jan 17 19:23:16 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 17 19:23:16 volumio mpd[8218]: decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:23:16 volumio mpd[8218]: output: No 'audio_output' defined in config file Jan 17 19:23:16 volumio mpd[8218]: output: Successfully detected a sndio audio device Jan 17 19:23:16 volumio mpd[8218]: zeroconf: No global port, disabling zeroconf Jan 17 19:23:16 volumio systemd[1]: Started Music Player Daemon. Jan 17 19:23:16 volumio sudo[8151]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio sudo[8142]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio sudo[8201]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:16 volumio volumio[7989]: info: Completed starting Core Plugins Jan 17 19:23:16 volumio volumio[7989]: info: ------------------------------------------- Jan 17 19:23:16 volumio volumio[7989]: info: ----- MyVolumio plugins startup ---- Jan 17 19:23:16 volumio volumio[7989]: info: ------------------------------------------- Jan 17 19:23:16 volumio volumio[7989]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 17 19:23:16 volumio volumio[7989]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:23:16 volumio volumio[7989]: assert.ok(self.idling) Jan 17 19:23:16 volumio volumio[7989]: error: The expression evaluated to a falsy value: Jan 17 19:23:16 volumio volumio[7989]: assert.ok(self.idling) Jan 17 19:23:16 volumio volumio[7989]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:23:16 volumio volumio[7989]: assert.ok(self.idling) Jan 17 19:23:16 volumio volumio[7989]: error: The expression evaluated to a falsy value: Jan 17 19:23:16 volumio volumio[7989]: assert.ok(self.idling) Jan 17 19:23:16 volumio volumio[7989]: error: updateQueue error: null Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 17 19:23:16 volumio volumio[7989]: info: MPD running with PID8218 Jan 17 19:23:16 volumio volumio[7989]: ,establishing connection Jan 17 19:23:16 volumio volumio[7989]: error: updateQueue error: null Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 17 19:23:16 volumio volumio[7989]: info: Received Get System Info Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 19:23:16 volumio volumio[7989]: info: Discovery: Getting this device information Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:23:16 volumio volumio[7989]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:16 volumio volumio[7989]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:16 volumio volumio[7989]: info: Listing playlists Jan 17 19:23:17 volumio volumio[7989]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:23:17 volumio volumio[7989]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:23:17 volumio volumio[7989]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:23:17 volumio volumio-remote-updater[794]: [2025-01-17 19:23:17] [connect] Successful connection Jan 17 19:23:17 volumio volumio-remote-updater[794]: [2025-01-17 19:23:17] [connect] WebSocket Connection 127.0.0.1:3000 v-2 "WebSocket++/0.8.2" /socket.io/?EIO=4&transport=websocket&t=1737138197 101 Jan 17 19:23:17 volumio volumio[7989]: 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: 6 Jan 17 19:23:19 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 7 Jan 17 19:23:19 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 8 Jan 17 19:23:19 volumio volumio[7989]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 9 Jan 17 19:23:22 volumio volumio[7989]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:23:23 volumio volumio[7989]: 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 Jan 17 19:23:23 volumio volumio[7989]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:23:23 volumio volumio[7989]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 19:23:23 volumio volumio[7989]: info: camilladsp service started and running in background, instance 1 Jan 17 19:23:23 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:26 volumio volumio[7989]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:23:26 volumio volumio[7989]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 17 19:23:26 volumio volumio[7989]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:23:26 volumio volumio[7989]: info: FusionDsp loaded Jan 17 19:23:26 volumio volumio[7989]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:23:26 volumio sudo[8257]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 19:23:26 volumio sudo[8257]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:26 volumio volumio[7989]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 19:23:26 volumio volumio[7989]: info: Adding Signal Path Element [object Object] Jan 17 19:23:26 volumio volumio[7989]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 19:23:26 volumio volumio[7989]: info: FusionDsp - ---- installed callbackRead Jan 17 19:23:26 volumio volumio[7989]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:23:26 volumio sudo[8257]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:26 volumio volumio[7989]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 19:23:26 volumio volumio[7989]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jan 17 19:23:26 volumio volumio[7989]: at onErrorNT (internal/child_process.js:472:16) Jan 17 19:23:26 volumio volumio[7989]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jan 17 19:23:26 volumio volumio[7989]: at runNextTicks (internal/process/task_queues.js:64:3) Jan 17 19:23:26 volumio volumio[7989]: at listOnTimeout (internal/timers.js:526:9) Jan 17 19:23:26 volumio volumio[7989]: at processTimers (internal/timers.js:500:7) { Jan 17 19:23:26 volumio volumio[7989]: errno: -2, Jan 17 19:23:26 volumio volumio[7989]: code: 'ENOENT', Jan 17 19:23:26 volumio volumio[7989]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:23:26 volumio volumio[7989]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:23:26 volumio volumio[7989]: spawnargs: [ Jan 17 19:23:26 volumio volumio[7989]: '-p', Jan 17 19:23:26 volumio volumio[7989]: 9876, Jan 17 19:23:26 volumio volumio[7989]: '-o', Jan 17 19:23:26 volumio volumio[7989]: '/tmp/camilladsp.log', Jan 17 19:23:26 volumio volumio[7989]: '-l', Jan 17 19:23:26 volumio volumio[7989]: 'warn', Jan 17 19:23:26 volumio volumio[7989]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 19:23:26 volumio volumio[7989]: ] Jan 17 19:23:26 volumio volumio[7989]: } Jan 17 19:23:26 volumio volumio[7989]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:23:26 volumio sudo[8268]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 19:22 Jan 17 19:23:26 volumio sudo[8268]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:26 volumio sudo[8268]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:26 volumio volumio-remote-updater[794]: [2025-01-17 19:23:26] [error] handle_read_frame error: websocketpp.transport:7 (End of File) Jan 17 19:23:26 volumio volumio-remote-updater[794]: [2025-01-17 19:23:26] [disconnect] Disconnect close local:[1006,End of File] remote:[1006] Jan 17 19:23:26 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 17 19:23:26 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 17 19:23:26 volumio systemd[1]: Started dynamicswap service. Jan 17 19:23:26 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:23:26 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 17 19:23:26 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 23. Jan 17 19:23:26 volumio systemd[1]: Stopped Volumio Backend Module. Jan 17 19:23:26 volumio systemd[1]: Started Volumio Backend Module. Jan 17 19:23:26 volumio systemd[1]: Started dynamicswap service. Jan 17 19:23:26 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:23:26 volumio volumio[8278]: info: ------------------------------------------- Jan 17 19:23:26 volumio volumio[8278]: info: ----- Volumio3 ---- Jan 17 19:23:26 volumio volumio[8278]: info: ------------------------------------------- Jan 17 19:23:26 volumio volumio[8278]: info: ----- System startup ---- Jan 17 19:23:26 volumio volumio[8278]: info: ------------------------------------------- Jan 17 19:23:27 volumio volumio[8278]: info: MYVOLUMIO Environment detected Jan 17 19:23:27 volumio volumio[8278]: info: Plugin folders cleanup Jan 17 19:23:27 volumio volumio[8278]: info: Scanning into folder /volumio/app/plugins/ Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category audio_interface Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category miscellanea Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category music_service Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category plugins.json Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category system_controller Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category user_interface Jan 17 19:23:27 volumio volumio[8278]: info: Scanning into folder /data/plugins/ Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category audio_interface Jan 17 19:23:27 volumio volumio[8278]: info: Scanning category user_interface Jan 17 19:23:27 volumio volumio[8278]: info: Plugin folders cleanup completed Jan 17 19:23:27 volumio volumio[8278]: info: ------------------------------------------- Jan 17 19:23:27 volumio volumio[8278]: info: ----- Core plugins startup ---- Jan 17 19:23:27 volumio volumio[8278]: info: ------------------------------------------- Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 19:23:27 volumio volumio[8278]: info: Adding plugin upnp to MyMusic Plugins Jan 17 19:23:27 volumio volumio[8278]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 19:23:27 volumio volumio[8278]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugins from folder /data/plugins/ Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "system"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "appearance"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "network"... Jan 17 19:23:27 volumio volumio[8278]: info: Refreshing Cached IP Addresses Jan 17 19:23:27 volumio sudo[8305]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:23:27 volumio sudo[8305]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:27 volumio sudo[8307]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:23:27 volumio sudo[8305]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:27 volumio sudo[8307]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "services"... Jan 17 19:23:27 volumio sudo[8307]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "alsa_controller"... Jan 17 19:23:27 volumio sudo[8316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 17 19:23:27 volumio sudo[8316]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "wizard"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "networkfs"... Jan 17 19:23:27 volumio volumio[8278]: info: Starting Udev Watcher for removable devices Jan 17 19:23:27 volumio volumio[8278]: info: Ignoring mount for partition: boot Jan 17 19:23:27 volumio volumio[8278]: info: Ignoring mount for partition: volumio Jan 17 19:23:27 volumio volumio[8278]: info: Ignoring mount for partition: volumio_data Jan 17 19:23:27 volumio volumio[8278]: info: Ignoring mount for partition: Zastrzeżone_przez_system Jan 17 19:23:27 volumio volumio[8278]: info: Ignoring mount for partition: B46AA8996AA859BE Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "volumio_command_line_client"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "upnp"... Jan 17 19:23:27 volumio volumio[8278]: info: [1737138207298] Starting Upmpd Daemon Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "my_music"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "mpd"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "upnp_browser"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "alarm-clock"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "airplay_emulation"... Jan 17 19:23:27 volumio volumio[8278]: info: Starting Shairport Sync Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "last_100"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "webradio"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "i2s_dacs"... Jan 17 19:23:27 volumio volumio[8278]: info: I2S DAC not set, start Auto-detection Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "volumiodiscovery"... Jan 17 19:23:27 volumio volumio[8278]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:27 volumio volumio[8278]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:27 volumio volumio[8278]: *** WARNING *** For more information see Jan 17 19:23:27 volumio volumio[8278]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:27 volumio volumio[8278]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:27 volumio volumio[8278]: *** WARNING *** For more information see Jan 17 19:23:27 volumio node[8278]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:27 volumio node[8278]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:27 volumio node[8278]: *** WARNING *** For more information see Jan 17 19:23:27 volumio node[8278]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:27 volumio node[8278]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:27 volumio node[8278]: *** WARNING *** For more information see Jan 17 19:23:27 volumio volumio[8278]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 19:23:27 volumio volumio[8278]: info: Discovery: Started advertising with name: Volumio Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "now_playing"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "outputs"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "albumart"... Jan 17 19:23:27 volumio volumio[8278]: info: Plugin example_plugin is not enabled Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "inputs"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "updater_comm"... Jan 17 19:23:27 volumio volumio[8278]: info: Plugin mpdemulation is not enabled Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "rest_api"... Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "websocket"... Jan 17 19:23:27 volumio volumio[8278]: info: Starting Socket.io Server version 2.3.0 Jan 17 19:23:27 volumio volumio[8278]: info: Loading plugin "fusiondsp"... Jan 17 19:23:27 volumio volumio[8278]: Forking 3 albumart workers Jan 17 19:23:27 volumio volumio[8278]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 19:23:27 volumio volumio[8278]: info: Loading i18n strings for locale pl Jan 17 19:23:27 volumio volumio[8278]: Updating browse sources language Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::initPlayerControls Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: Express server listening on port 3000 Jan 17 19:23:27 volumio volumio[8278]: [Metrics] WebUI: 1s 183.71ms Jan 17 19:23:27 volumio volumio[8278]: info: Setting Device type: x86 Jan 17 19:23:27 volumio volumio[8278]: info: CoreStateMachine::resetVolumioState Jan 17 19:23:27 volumio volumio[8278]: info: CoreStateMachine::getcurrentVolume Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:23:27 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:27 volumio volumio[8278]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 17 19:23:27 volumio volumio[8278]: info: Completed loading Core Plugins Jan 17 19:23:27 volumio volumio[8278]: info: Preparing to generate the ALSA configuration file Jan 17 19:23:27 volumio volumio[8278]: Starting albumart workers Jan 17 19:23:27 volumio volumio[8278]: info: Cannot read play queue from file Jan 17 19:23:28 volumio volumio[8278]: Starting albumart workers Jan 17 19:23:28 volumio volumio[8278]: Starting albumart workers Jan 17 19:23:28 volumio volumio[8278]: info: Volumio Network Manager: Network status updated: 2 Jan 17 19:23:28 volumio volumio[8278]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 17 19:23:28 volumio volumio[8278]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:23:28 volumio volumio[8278]: info: Reading ALSA contributions from plugins. Jan 17 19:23:28 volumio volumio[8278]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 1 Jan 17 19:23:28 volumio volumio[8278]: info: CoreStateMachine::setRepeat null single undefined Jan 17 19:23:28 volumio volumio[8278]: info: CoreStateMachine::pushState Jan 17 19:23:28 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:28 volumio volumio[8278]: info: CoreStateMachine::setRandom null Jan 17 19:23:28 volumio volumio[8278]: info: CoreStateMachine::pushState Jan 17 19:23:28 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:28 volumio volumio[8278]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:23:28 volumio volumio[8278]: info: CoreStateMachine::pushState Jan 17 19:23:28 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:28 volumio volumio[8278]: info: CoreStateMachine::updateTrackBlock Jan 17 19:23:28 volumio volumio[8278]: info: CorePlayQueue::getTrackBlock Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:23:28 volumio volumio[8278]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:23:28 volumio volumio[8278]: info: Output device has changed, restarting MPD Jan 17 19:23:28 volumio sudo[8400]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:28 volumio sudo[8400]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio volumio[8278]: info: Output device has changed, restarting Shairport Sync Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio sudo[8400]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio sudo[8403]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:28 volumio sudo[8403]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 19:23:28 volumio volumio[8278]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:28 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:28 volumio volumio[8278]: info: ___________ START PLUGINS ___________ Jan 17 19:23:28 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:28 volumio volumio[8278]: info: ControllerMpd::onStart: Initializing MPD Jan 17 19:23:28 volumio volumio[8278]: info: Creating MPD Configuration file Jan 17 19:23:28 volumio sudo[8410]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:28 volumio volumio[8278]: info: [1737138208239] CoreMusicLibrary::Adding element Serwery Mediów Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:28 volumio sudo[8410]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio sudo[8410]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio sudo[8412]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:28 volumio sudo[8412]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 17 19:23:28 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:28 volumio volumio[8278]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:28 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:28 volumio volumio[8278]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:28 volumio volumio[8278]: info: [1737138208275] CoreMusicLibrary::Adding element Last_100 Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:28 volumio volumio[8278]: info: [1737138208276] CoreMusicLibrary::Adding element Webradio Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:28 volumio volumio[8278]: info: Initializing BBC Radios Jan 17 19:23:28 volumio sudo[8418]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:23:28 volumio sudo[8418]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio sudo[8418]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: [now-playing] ConfigUpdater: config is up to date. Jan 17 19:23:28 volumio volumio[8278]: info: Loading i18n strings for locale pl Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: FusionDsp - mixtype--------------------- Hardware Jan 17 19:23:28 volumio volumio[8278]: info: Volumio Calling Home Jan 17 19:23:28 volumio volumio[8278]: info: Preparing to generate the ALSA configuration file Jan 17 19:23:28 volumio volumio[8278]: info: [now-playing] App is listening on port 4004. Jan 17 19:23:28 volumio volumio[8278]: warn: [now-playing] /data/INTERNAL/NowPlayingPlugin/My Backgrounds does not exist. MyBackgroundMonitor will not start. Jan 17 19:23:28 volumio volumio[8278]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:23:28 volumio volumio[8278]: info: Reading ALSA contributions from plugins. Jan 17 19:23:28 volumio volumio[8278]: info: MPD Permissions set Jan 17 19:23:28 volumio volumio[8278]: info: MPD Permissions set Jan 17 19:23:28 volumio volumio[8278]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:23:28 volumio volumio[8278]: info: CoreStateMachine::pushState Jan 17 19:23:28 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:28 volumio volumio[8278]: info: Starting Shairport Sync Jan 17 19:23:28 volumio volumio[8278]: info: Starting Shairport Sync Jan 17 19:23:28 volumio volumio[8278]: info: Starting Shairport Sync Jan 17 19:23:28 volumio sudo[8452]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:28 volumio sudo[8452]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio sudo[8454]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:28 volumio sudo[8454]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:28 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:28 volumio sudo[8458]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:28 volumio sudo[8458]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:28 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:28 volumio volumio[8278]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:23:28 volumio volumio[8278]: info: Output device has changed, restarting MPD Jan 17 19:23:28 volumio volumio[8278]: info: Output device has changed, restarting Shairport Sync Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:28 volumio sudo[8462]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:28 volumio sudo[8462]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio sudo[8462]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio sudo[8464]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:28 volumio sudo[8464]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio sudo[8452]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:28 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 19:23:28 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:28 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:28 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jan 17 19:23:28 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:28 volumio volumio[8278]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:28 volumio sudo[8454]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:28 volumio sudo[8458]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio volumio[8278]: info: MPD Permissions set Jan 17 19:23:28 volumio volumio[8278]: info: Shairport-Sync Started Jan 17 19:23:28 volumio volumio[8278]: Error adding Membership: Error: addMembership EINVAL Jan 17 19:23:28 volumio volumio[8278]: info: Volumio called home Jan 17 19:23:28 volumio volumio[8278]: info: Shairport-Sync Started Jan 17 19:23:28 volumio volumio[8278]: info: Shairport-Sync Started Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:28 volumio sudo[8471]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:23:28 volumio sudo[8471]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio sudo[8471]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:28 volumio volumio[8278]: info: Starting Shairport Sync Jan 17 19:23:28 volumio sudo[8483]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:28 volumio sudo[8483]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:28 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:28 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:28 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:28 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:28 volumio sudo[8483]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio volumio[8278]: info: Shairport-Sync Started Jan 17 19:23:28 volumio volumio[8278]: info: Discovery: adding db590945-5fbf-4bfa-8882-0bd01dc22477 Jan 17 19:23:28 volumio volumio[8278]: info: Discovery: Found device Volumio Jan 17 19:23:28 volumio volumio[8278]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:28 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:28 volumio mpd[8481]: Jan 17 19:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:23:28 volumio systemd[1]: Started Music Player Daemon. Jan 17 19:23:28 volumio sudo[8412]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio sudo[8403]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio sudo[8464]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:28 volumio volumio[8278]: info: Completed starting Core Plugins Jan 17 19:23:28 volumio volumio[8278]: info: ------------------------------------------- Jan 17 19:23:28 volumio volumio[8278]: info: ----- MyVolumio plugins startup ---- Jan 17 19:23:28 volumio volumio[8278]: info: ------------------------------------------- Jan 17 19:23:28 volumio volumio[8278]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 17 19:23:28 volumio volumio[8278]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:23:28 volumio volumio[8278]: assert.ok(self.idling) Jan 17 19:23:28 volumio volumio[8278]: error: The expression evaluated to a falsy value: Jan 17 19:23:28 volumio volumio[8278]: assert.ok(self.idling) Jan 17 19:23:28 volumio volumio[8278]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:23:28 volumio volumio[8278]: assert.ok(self.idling) Jan 17 19:23:28 volumio volumio[8278]: error: The expression evaluated to a falsy value: Jan 17 19:23:28 volumio volumio[8278]: assert.ok(self.idling) Jan 17 19:23:28 volumio volumio[8278]: error: updateQueue error: null Jan 17 19:23:28 volumio volumio[8278]: info: MPD running with PID8481 Jan 17 19:23:28 volumio volumio[8278]: ,establishing connection Jan 17 19:23:28 volumio volumio[8278]: error: updateQueue error: null Jan 17 19:23:29 volumio volumio[8278]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:23:29 volumio volumio[8278]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 19:23:29 volumio volumio[8278]: info: Discovery: Getting this device information Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:29 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:23:29 volumio volumio[8278]: info: Listing playlists Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::volumioGetQueue Jan 17 19:23:29 volumio volumio[8278]: info: CoreStateMachine::getQueue Jan 17 19:23:29 volumio volumio[8278]: info: CorePlayQueue::getQueue Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:29 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:29 volumio volumio[8278]: info: CALLMETHOD: user_interface now_playing getPluginInfo undefined Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: now_playing , getPluginInfo Jan 17 19:23:29 volumio volumio[8278]: info: Listing playlists Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::volumioGetQueue Jan 17 19:23:29 volumio volumio[8278]: info: CoreStateMachine::getQueue Jan 17 19:23:29 volumio volumio[8278]: info: CorePlayQueue::getQueue Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:29 volumio volumio[8278]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:29 volumio volumio[8278]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:29 volumio sudo[8316]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:31 volumio volumio-remote-updater[794]: [2025-01-17 19:23:31] [connect] Successful connection Jan 17 19:23:32 volumio volumio[8278]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:23:32 volumio volumio[8278]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 4 Jan 17 19:23:32 volumio volumio[8278]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 17 19:23:32 volumio volumio[8278]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 6 Jan 17 19:23:32 volumio volumio[8278]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:23:32 volumio volumio[8278]: 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 Jan 17 19:23:32 volumio volumio[8278]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:23:32 volumio volumio[8278]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 19:23:32 volumio volumio[8278]: info: camilladsp service started and running in background, instance 1 Jan 17 19:23:32 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:32 volumio volumio[8278]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:23:32 volumio volumio[8278]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 17 19:23:32 volumio volumio[8278]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:23:32 volumio volumio[8278]: info: FusionDsp loaded Jan 17 19:23:32 volumio volumio[8278]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:23:32 volumio sudo[8507]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 19:23:32 volumio sudo[8507]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:32 volumio volumio[8278]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 19:23:32 volumio volumio[8278]: info: Adding Signal Path Element [object Object] Jan 17 19:23:32 volumio volumio[8278]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 19:23:32 volumio volumio[8278]: info: FusionDsp - ---- installed callbackRead Jan 17 19:23:32 volumio volumio[8278]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:23:32 volumio sudo[8507]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:32 volumio volumio[8278]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 19:23:32 volumio volumio[8278]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jan 17 19:23:32 volumio volumio[8278]: at onErrorNT (internal/child_process.js:472:16) Jan 17 19:23:32 volumio volumio[8278]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jan 17 19:23:32 volumio volumio[8278]: at runNextTicks (internal/process/task_queues.js:64:3) Jan 17 19:23:32 volumio volumio[8278]: at listOnTimeout (internal/timers.js:526:9) Jan 17 19:23:32 volumio volumio[8278]: at processTimers (internal/timers.js:500:7) { Jan 17 19:23:32 volumio volumio[8278]: errno: -2, Jan 17 19:23:32 volumio volumio[8278]: code: 'ENOENT', Jan 17 19:23:32 volumio volumio[8278]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:23:32 volumio volumio[8278]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:23:32 volumio volumio[8278]: spawnargs: [ Jan 17 19:23:32 volumio volumio[8278]: '-p', Jan 17 19:23:32 volumio volumio[8278]: 9876, Jan 17 19:23:32 volumio volumio[8278]: '-o', Jan 17 19:23:32 volumio volumio[8278]: '/tmp/camilladsp.log', Jan 17 19:23:32 volumio volumio[8278]: '-l', Jan 17 19:23:32 volumio volumio[8278]: 'warn', Jan 17 19:23:32 volumio volumio[8278]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 19:23:32 volumio volumio[8278]: ] Jan 17 19:23:32 volumio volumio[8278]: } Jan 17 19:23:32 volumio volumio[8278]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:23:32 volumio sudo[8518]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 19:22 Jan 17 19:23:32 volumio sudo[8518]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:32 volumio sudo[8518]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:32 volumio volumio-remote-updater[794]: [2025-01-17 19:23:32] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jan 17 19:23:32 volumio volumio-remote-updater[794]: [2025-01-17 19:23:32] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jan 17 19:23:32 volumio volumio-remote-updater[794]: [2025-01-17 19:23:32] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 17 19:23:32 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 17 19:23:32 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 17 19:23:33 volumio systemd[1]: Started dynamicswap service. Jan 17 19:23:33 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:23:33 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 17 19:23:33 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 24. Jan 17 19:23:33 volumio systemd[1]: Stopped Volumio Backend Module. Jan 17 19:23:33 volumio systemd[1]: Started Volumio Backend Module. Jan 17 19:23:33 volumio systemd[1]: Started dynamicswap service. Jan 17 19:23:33 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:23:33 volumio volumio[8528]: info: ------------------------------------------- Jan 17 19:23:33 volumio volumio[8528]: info: ----- Volumio3 ---- Jan 17 19:23:33 volumio volumio[8528]: info: ------------------------------------------- Jan 17 19:23:33 volumio volumio[8528]: info: ----- System startup ---- Jan 17 19:23:33 volumio volumio[8528]: info: ------------------------------------------- Jan 17 19:23:36 volumio volumio[8528]: info: MYVOLUMIO Environment detected Jan 17 19:23:36 volumio volumio[8528]: info: Plugin folders cleanup Jan 17 19:23:36 volumio volumio[8528]: info: Scanning into folder /volumio/app/plugins/ Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category audio_interface Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category miscellanea Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category music_service Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category plugins.json Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category system_controller Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category user_interface Jan 17 19:23:36 volumio volumio[8528]: info: Scanning into folder /data/plugins/ Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category audio_interface Jan 17 19:23:36 volumio volumio[8528]: info: Scanning category user_interface Jan 17 19:23:36 volumio volumio[8528]: info: Plugin folders cleanup completed Jan 17 19:23:36 volumio volumio[8528]: info: ------------------------------------------- Jan 17 19:23:36 volumio volumio[8528]: info: ----- Core plugins startup ---- Jan 17 19:23:36 volumio volumio[8528]: info: ------------------------------------------- Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 19:23:36 volumio volumio[8528]: info: Adding plugin upnp to MyMusic Plugins Jan 17 19:23:36 volumio volumio[8528]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 19:23:36 volumio volumio[8528]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugins from folder /data/plugins/ Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "system"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "appearance"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "network"... Jan 17 19:23:36 volumio volumio[8528]: info: Refreshing Cached IP Addresses Jan 17 19:23:36 volumio sudo[8555]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:23:36 volumio sudo[8555]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:36 volumio sudo[8555]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:36 volumio sudo[8557]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:23:36 volumio sudo[8557]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:36 volumio sudo[8557]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "services"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "alsa_controller"... Jan 17 19:23:36 volumio sudo[8566]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 17 19:23:36 volumio sudo[8566]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:36 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "wizard"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "networkfs"... Jan 17 19:23:36 volumio volumio[8528]: info: Starting Udev Watcher for removable devices Jan 17 19:23:36 volumio volumio[8528]: info: Ignoring mount for partition: boot Jan 17 19:23:36 volumio volumio[8528]: info: Ignoring mount for partition: volumio Jan 17 19:23:36 volumio volumio[8528]: info: Ignoring mount for partition: volumio_data Jan 17 19:23:36 volumio volumio[8528]: info: Ignoring mount for partition: Zastrzeżone_przez_system Jan 17 19:23:36 volumio volumio[8528]: info: Ignoring mount for partition: B46AA8996AA859BE Jan 17 19:23:36 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "volumio_command_line_client"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "upnp"... Jan 17 19:23:36 volumio volumio[8528]: info: [1737138216395] Starting Upmpd Daemon Jan 17 19:23:36 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "my_music"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "mpd"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "upnp_browser"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "alarm-clock"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "airplay_emulation"... Jan 17 19:23:36 volumio volumio[8528]: info: Starting Shairport Sync Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "last_100"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "webradio"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "i2s_dacs"... Jan 17 19:23:36 volumio volumio[8528]: info: I2S DAC not set, start Auto-detection Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "volumiodiscovery"... Jan 17 19:23:36 volumio volumio[8528]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:36 volumio volumio[8528]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:36 volumio volumio[8528]: *** WARNING *** For more information see Jan 17 19:23:36 volumio volumio[8528]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:36 volumio volumio[8528]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:36 volumio volumio[8528]: *** WARNING *** For more information see Jan 17 19:23:36 volumio node[8528]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:36 volumio node[8528]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:36 volumio node[8528]: *** WARNING *** For more information see Jan 17 19:23:36 volumio node[8528]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:36 volumio node[8528]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:36 volumio node[8528]: *** WARNING *** For more information see Jan 17 19:23:36 volumio volumio[8528]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 19:23:36 volumio volumio[8528]: info: Discovery: Started advertising with name: Volumio Jan 17 19:23:36 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "now_playing"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "outputs"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "albumart"... Jan 17 19:23:36 volumio volumio[8528]: info: Plugin example_plugin is not enabled Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "inputs"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "updater_comm"... Jan 17 19:23:36 volumio volumio[8528]: info: Plugin mpdemulation is not enabled Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "rest_api"... Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "websocket"... Jan 17 19:23:36 volumio volumio[8528]: info: Starting Socket.io Server version 2.3.0 Jan 17 19:23:36 volumio volumio[8528]: info: Loading plugin "fusiondsp"... Jan 17 19:23:36 volumio volumio[8528]: Forking 3 albumart workers Jan 17 19:23:36 volumio volumio[8528]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 19:23:36 volumio volumio[8528]: info: Loading i18n strings for locale pl Jan 17 19:23:36 volumio volumio[8528]: Updating browse sources language Jan 17 19:23:36 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::initPlayerControls Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: Express server listening on port 3000 Jan 17 19:23:37 volumio volumio[8528]: [Metrics] WebUI: 3s 540.00ms Jan 17 19:23:37 volumio volumio[8528]: info: Setting Device type: x86 Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::resetVolumioState Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::getcurrentVolume Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 17 19:23:37 volumio volumio[8528]: info: Completed loading Core Plugins Jan 17 19:23:37 volumio volumio[8528]: info: Preparing to generate the ALSA configuration file Jan 17 19:23:37 volumio volumio[8528]: Starting albumart workers Jan 17 19:23:37 volumio volumio[8528]: info: Cannot read play queue from file Jan 17 19:23:37 volumio volumio[8528]: Starting albumart workers Jan 17 19:23:37 volumio volumio[8528]: Starting albumart workers Jan 17 19:23:37 volumio volumio[8528]: info: Volumio Network Manager: Network status updated: 2 Jan 17 19:23:37 volumio volumio[8528]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 17 19:23:37 volumio volumio[8528]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:23:37 volumio volumio[8528]: info: Reading ALSA contributions from plugins. Jan 17 19:23:37 volumio volumio[8528]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 1 Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::setRepeat null single undefined Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::pushState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::setRandom null Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::pushState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:37 volumio volumio[8528]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::pushState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::updateTrackBlock Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrackBlock Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:23:37 volumio volumio[8528]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:23:37 volumio volumio[8528]: info: Output device has changed, restarting MPD Jan 17 19:23:37 volumio sudo[8646]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:37 volumio sudo[8646]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio volumio[8528]: info: Output device has changed, restarting Shairport Sync Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio sudo[8646]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio sudo[8653]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:37 volumio sudo[8653]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 19:23:37 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:37 volumio volumio[8528]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:37 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:37 volumio volumio[8528]: info: ___________ START PLUGINS ___________ Jan 17 19:23:37 volumio volumio[8528]: info: ControllerMpd::onStart: Initializing MPD Jan 17 19:23:37 volumio volumio[8528]: info: Creating MPD Configuration file Jan 17 19:23:37 volumio sudo[8660]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:37 volumio sudo[8660]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:37 volumio volumio[8528]: info: [1737138217330] CoreMusicLibrary::Adding element Serwery Mediów Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:37 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:37 volumio sudo[8660]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio sudo[8662]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:37 volumio sudo[8662]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 17 19:23:37 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:37 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:37 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:37 volumio volumio[8528]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:37 volumio volumio[8528]: info: [1737138217367] CoreMusicLibrary::Adding element Last_100 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:37 volumio sudo[8665]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:23:37 volumio sudo[8665]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio volumio[8528]: info: [1737138217368] CoreMusicLibrary::Adding element Webradio Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:37 volumio sudo[8665]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio volumio[8528]: info: Initializing BBC Radios Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: [now-playing] ConfigUpdater: config is up to date. Jan 17 19:23:37 volumio volumio[8528]: info: Loading i18n strings for locale pl Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: FusionDsp - mixtype--------------------- Hardware Jan 17 19:23:37 volumio volumio[8528]: info: Volumio Calling Home Jan 17 19:23:37 volumio volumio[8528]: info: Preparing to generate the ALSA configuration file Jan 17 19:23:37 volumio volumio[8528]: info: [now-playing] App is listening on port 4004. Jan 17 19:23:37 volumio volumio[8528]: warn: [now-playing] /data/INTERNAL/NowPlayingPlugin/My Backgrounds does not exist. MyBackgroundMonitor will not start. Jan 17 19:23:37 volumio volumio[8528]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:23:37 volumio volumio[8528]: info: Reading ALSA contributions from plugins. Jan 17 19:23:37 volumio volumio[8528]: info: MPD Permissions set Jan 17 19:23:37 volumio volumio[8528]: info: MPD Permissions set Jan 17 19:23:37 volumio volumio[8528]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:23:37 volumio volumio[8528]: info: CoreStateMachine::pushState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioPushState Jan 17 19:23:37 volumio volumio[8528]: info: Starting Shairport Sync Jan 17 19:23:37 volumio volumio[8528]: info: Starting Shairport Sync Jan 17 19:23:37 volumio sudo[8701]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:37 volumio sudo[8701]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio volumio[8528]: info: Starting Shairport Sync Jan 17 19:23:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:37 volumio sudo[8704]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:37 volumio sudo[8704]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:37 volumio sudo[8708]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:37 volumio sudo[8708]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:23:37 volumio volumio[8528]: info: Output device has changed, restarting MPD Jan 17 19:23:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:37 volumio sudo[8701]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio sudo[8711]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:23:37 volumio sudo[8711]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio sudo[8711]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:37 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:37 volumio volumio[8528]: info: Output device has changed, restarting Shairport Sync Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:37 volumio sudo[8708]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio sudo[8704]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio sudo[8715]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:23:37 volumio sudo[8715]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 19:23:37 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:23:37 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:23:37 volumio volumio[8528]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:23:37 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:23:37 volumio volumio[8528]: info: MPD Permissions set Jan 17 19:23:37 volumio volumio[8528]: info: Shairport-Sync Started Jan 17 19:23:37 volumio volumio[8528]: Error adding Membership: Error: addMembership EINVAL Jan 17 19:23:37 volumio volumio[8528]: info: Shairport-Sync Started Jan 17 19:23:37 volumio volumio[8528]: info: Shairport-Sync Started Jan 17 19:23:37 volumio volumio[8528]: info: Volumio called home Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio sudo[8723]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:23:37 volumio sudo[8723]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio sudo[8723]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:37 volumio volumio[8528]: info: Starting Shairport Sync Jan 17 19:23:37 volumio sudo[8734]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:23:37 volumio sudo[8734]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:37 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:23:37 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:23:37 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:37 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Jan 17 19:23:37 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Jan 17 19:23:37 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Jan 17 19:23:37 volumio sudo[8734]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio volumio[8528]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Jan 17 19:23:37 volumio volumio[8528]: Job for shairport-sync.service failed. Jan 17 19:23:37 volumio volumio[8528]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Jan 17 19:23:37 volumio volumio[8528]: info: Discovery: adding db590945-5fbf-4bfa-8882-0bd01dc22477 Jan 17 19:23:37 volumio volumio[8528]: info: Discovery: Found device Volumio Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 17 19:23:37 volumio volumio[8528]: info: Received Get System Info Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 19:23:37 volumio volumio[8528]: info: Discovery: Getting this device information Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::volumioGetState Jan 17 19:23:37 volumio volumio[8528]: info: CorePlayQueue::getTrack 0 Jan 17 19:23:37 volumio volumio[8528]: info: Listing playlists Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:23:37 volumio volumio[8528]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:23:37 volumio mpd[8730]: Jan 17 19:23 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:23:37 volumio systemd[1]: Started Music Player Daemon. Jan 17 19:23:37 volumio sudo[8653]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio sudo[8662]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:37 volumio sudo[8715]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:38 volumio volumio[8528]: info: Completed starting Core Plugins Jan 17 19:23:38 volumio volumio[8528]: info: ------------------------------------------- Jan 17 19:23:38 volumio volumio[8528]: info: ----- MyVolumio plugins startup ---- Jan 17 19:23:38 volumio volumio[8528]: info: ------------------------------------------- Jan 17 19:23:38 volumio volumio[8528]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 17 19:23:38 volumio volumio[8528]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:23:38 volumio volumio[8528]: assert.ok(self.idling) Jan 17 19:23:38 volumio volumio[8528]: error: The expression evaluated to a falsy value: Jan 17 19:23:38 volumio volumio[8528]: assert.ok(self.idling) Jan 17 19:23:38 volumio volumio[8528]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:23:38 volumio volumio[8528]: assert.ok(self.idling) Jan 17 19:23:38 volumio volumio[8528]: error: The expression evaluated to a falsy value: Jan 17 19:23:38 volumio volumio[8528]: assert.ok(self.idling) Jan 17 19:23:38 volumio volumio[8528]: info: MPD running with PID8730 Jan 17 19:23:38 volumio volumio[8528]: ,establishing connection Jan 17 19:23:38 volumio volumio[8528]: error: updateQueue error: null Jan 17 19:23:38 volumio volumio[8528]: error: updateQueue error: null Jan 17 19:23:39 volumio sudo[8566]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:40 volumio volumio-remote-updater[794]: [2025-01-17 19:23:40] [connect] Successful connection Jan 17 19:23:41 volumio volumio[8528]: warn: [now-playing] MyBackgroundMonitor stopped Jan 17 19:23:41 volumio volumio[8528]: info: Disabling plugin now_playing Jan 17 19:23:41 volumio volumio[8528]: info: Done. Jan 17 19:23:41 volumio volumio[8528]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 4 Jan 17 19:23:41 volumio volumio[8528]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 17 19:23:41 volumio volumio[8528]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 6 Jan 17 19:23:53 volumio volumio[8528]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:23:53 volumio volumio[8528]: 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 Jan 17 19:23:53 volumio volumio[8528]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:23:53 volumio volumio[8528]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 19:23:53 volumio volumio[8528]: info: camilladsp service started and running in background, instance 1 Jan 17 19:23:53 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:23:53 volumio volumio[8528]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:23:53 volumio volumio[8528]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 17 19:23:53 volumio volumio[8528]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:23:53 volumio volumio[8528]: info: FusionDsp loaded Jan 17 19:23:53 volumio volumio[8528]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:23:53 volumio sudo[8816]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 19:23:53 volumio sudo[8816]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:53 volumio volumio[8528]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 19:23:53 volumio volumio[8528]: info: Adding Signal Path Element [object Object] Jan 17 19:23:53 volumio volumio[8528]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 19:23:53 volumio volumio[8528]: info: FusionDsp - ---- installed callbackRead Jan 17 19:23:53 volumio volumio[8528]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:23:53 volumio sudo[8816]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:53 volumio volumio[8528]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 19:23:53 volumio volumio[8528]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jan 17 19:23:53 volumio volumio[8528]: at onErrorNT (internal/child_process.js:472:16) Jan 17 19:23:53 volumio volumio[8528]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jan 17 19:23:53 volumio volumio[8528]: at runNextTicks (internal/process/task_queues.js:64:3) Jan 17 19:23:53 volumio volumio[8528]: at listOnTimeout (internal/timers.js:526:9) Jan 17 19:23:53 volumio volumio[8528]: at processTimers (internal/timers.js:500:7) { Jan 17 19:23:53 volumio volumio[8528]: errno: -2, Jan 17 19:23:53 volumio volumio[8528]: code: 'ENOENT', Jan 17 19:23:53 volumio volumio[8528]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:23:53 volumio volumio[8528]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:23:53 volumio volumio[8528]: spawnargs: [ Jan 17 19:23:53 volumio volumio[8528]: '-p', Jan 17 19:23:53 volumio volumio[8528]: 9876, Jan 17 19:23:53 volumio volumio[8528]: '-o', Jan 17 19:23:53 volumio volumio[8528]: '/tmp/camilladsp.log', Jan 17 19:23:53 volumio volumio[8528]: '-l', Jan 17 19:23:53 volumio volumio[8528]: 'warn', Jan 17 19:23:53 volumio volumio[8528]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 19:23:53 volumio volumio[8528]: ] Jan 17 19:23:53 volumio volumio[8528]: } Jan 17 19:23:53 volumio volumio[8528]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:23:53 volumio sudo[8827]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 19:22 Jan 17 19:23:53 volumio sudo[8827]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:53 volumio sudo[8827]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:53 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 17 19:23:53 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 17 19:23:53 volumio systemd[1]: Started dynamicswap service. Jan 17 19:23:53 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:23:54 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 17 19:23:54 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 25. Jan 17 19:23:54 volumio systemd[1]: Stopped Volumio Backend Module. Jan 17 19:23:54 volumio systemd[1]: Started Volumio Backend Module. Jan 17 19:23:54 volumio systemd[1]: Started dynamicswap service. Jan 17 19:23:54 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:23:54 volumio volumio[8837]: info: ------------------------------------------- Jan 17 19:23:54 volumio volumio[8837]: info: ----- Volumio3 ---- Jan 17 19:23:54 volumio volumio[8837]: info: ------------------------------------------- Jan 17 19:23:54 volumio volumio[8837]: info: ----- System startup ---- Jan 17 19:23:54 volumio volumio[8837]: info: ------------------------------------------- Jan 17 19:23:54 volumio volumio[8837]: info: MYVOLUMIO Environment detected Jan 17 19:23:54 volumio volumio[8837]: info: Plugin folders cleanup Jan 17 19:23:54 volumio volumio[8837]: info: Scanning into folder /volumio/app/plugins/ Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category audio_interface Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category miscellanea Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category music_service Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category plugins.json Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category system_controller Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category user_interface Jan 17 19:23:54 volumio volumio[8837]: info: Scanning into folder /data/plugins/ Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category audio_interface Jan 17 19:23:54 volumio volumio[8837]: info: Scanning category user_interface Jan 17 19:23:54 volumio volumio[8837]: info: Plugin folders cleanup completed Jan 17 19:23:54 volumio volumio[8837]: info: ------------------------------------------- Jan 17 19:23:54 volumio volumio[8837]: info: ----- Core plugins startup ---- Jan 17 19:23:54 volumio volumio[8837]: info: ------------------------------------------- Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 19:23:54 volumio volumio[8837]: info: Adding plugin upnp to MyMusic Plugins Jan 17 19:23:54 volumio volumio[8837]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 19:23:54 volumio volumio[8837]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugins from folder /data/plugins/ Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "system"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "appearance"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "network"... Jan 17 19:23:54 volumio volumio[8837]: info: Refreshing Cached IP Addresses Jan 17 19:23:54 volumio sudo[8864]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:23:54 volumio sudo[8864]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:54 volumio sudo[8866]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:23:54 volumio sudo[8866]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:54 volumio sudo[8864]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:54 volumio sudo[8866]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "services"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "alsa_controller"... Jan 17 19:23:54 volumio sudo[8879]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 17 19:23:54 volumio sudo[8879]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:23:54 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "wizard"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "networkfs"... Jan 17 19:23:54 volumio volumio[8837]: info: Starting Udev Watcher for removable devices Jan 17 19:23:54 volumio volumio[8837]: info: Ignoring mount for partition: boot Jan 17 19:23:54 volumio volumio[8837]: info: Ignoring mount for partition: volumio Jan 17 19:23:54 volumio volumio[8837]: info: Ignoring mount for partition: volumio_data Jan 17 19:23:54 volumio volumio[8837]: info: Ignoring mount for partition: Zastrzeżone_przez_system Jan 17 19:23:54 volumio volumio[8837]: info: Ignoring mount for partition: B46AA8996AA859BE Jan 17 19:23:54 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "volumio_command_line_client"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "upnp"... Jan 17 19:23:54 volumio volumio[8837]: info: [1737138234786] Starting Upmpd Daemon Jan 17 19:23:54 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "my_music"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "mpd"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "upnp_browser"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "alarm-clock"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "airplay_emulation"... Jan 17 19:23:54 volumio volumio[8837]: info: Starting Shairport Sync Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "last_100"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "webradio"... Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "i2s_dacs"... Jan 17 19:23:54 volumio volumio[8837]: info: I2S DAC not set, start Auto-detection Jan 17 19:23:54 volumio volumio[8837]: info: Loading plugin "volumiodiscovery"... Jan 17 19:23:54 volumio volumio[8837]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:54 volumio volumio[8837]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:54 volumio volumio[8837]: *** WARNING *** For more information see Jan 17 19:23:54 volumio node[8837]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:54 volumio volumio[8837]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:54 volumio volumio[8837]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:54 volumio volumio[8837]: *** WARNING *** For more information see Jan 17 19:23:54 volumio node[8837]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:54 volumio node[8837]: *** WARNING *** For more information see Jan 17 19:23:54 volumio node[8837]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:23:54 volumio node[8837]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:23:54 volumio node[8837]: *** WARNING *** For more information see Jan 17 19:23:54 volumio volumio[8837]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 19:23:55 volumio volumio-remote-updater[794]: [2025-01-17 19:23:55] [connect] Successful connection Jan 17 19:23:56 volumio volumio[8837]: info: Discovery: Started advertising with name: Volumio Jan 17 19:23:56 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:23:56 volumio volumio[8837]: info: Plugin now_playing is not enabled Jan 17 19:23:56 volumio volumio[8837]: info: Loading plugin "outputs"... Jan 17 19:23:56 volumio volumio[8837]: info: Loading plugin "albumart"... Jan 17 19:23:57 volumio volumio[8837]: info: Plugin example_plugin is not enabled Jan 17 19:23:57 volumio volumio[8837]: info: Loading plugin "inputs"... Jan 17 19:23:57 volumio volumio[8837]: info: Loading plugin "updater_comm"... Jan 17 19:23:57 volumio volumio[8837]: info: Plugin mpdemulation is not enabled Jan 17 19:23:57 volumio volumio[8837]: info: Loading plugin "rest_api"... Jan 17 19:23:57 volumio volumio[8837]: Forking 3 albumart workers Jan 17 19:23:57 volumio volumio[8837]: info: Loading plugin "websocket"... Jan 17 19:23:57 volumio volumio[8837]: info: Starting Socket.io Server version 2.3.0 Jan 17 19:23:57 volumio volumio[8837]: info: Loading plugin "fusiondsp"... Jan 17 19:23:57 volumio sudo[8879]: pam_unix(sudo:session): session closed for user root Jan 17 19:23:57 volumio volumio[8837]: Starting albumart workers Jan 17 19:23:57 volumio volumio[8837]: Starting albumart workers Jan 17 19:23:57 volumio volumio[8837]: Starting albumart workers Jan 17 19:24:03 volumio volumio[8837]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 19:24:03 volumio volumio[8837]: info: Loading i18n strings for locale pl Jan 17 19:24:03 volumio volumio[8837]: Updating browse sources language Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::initPlayerControls Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:03 volumio volumio[8837]: Express server listening on port 3000 Jan 17 19:24:03 volumio volumio[8837]: [Metrics] WebUI: 9s 101.65ms Jan 17 19:24:03 volumio volumio[8837]: info: Setting Device type: x86 Jan 17 19:24:03 volumio volumio[8837]: info: CoreStateMachine::resetVolumioState Jan 17 19:24:03 volumio volumio[8837]: info: CoreStateMachine::getcurrentVolume Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:24:03 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 17 19:24:06 volumio volumio[8837]: info: Completed loading Core Plugins Jan 17 19:24:06 volumio volumio[8837]: info: Preparing to generate the ALSA configuration file Jan 17 19:24:06 volumio volumio[8837]: info: Cannot read play queue from file Jan 17 19:24:06 volumio volumio[8837]: info: Volumio Network Manager: Network status updated: 2 Jan 17 19:24:06 volumio volumio[8837]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 17 19:24:06 volumio sudo[8971]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:24:06 volumio sudo[8971]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio volumio[8837]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:24:06 volumio volumio[8837]: info: Reading ALSA contributions from plugins. Jan 17 19:24:06 volumio sudo[8971]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:06 volumio sudo[8973]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:24:06 volumio sudo[8973]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio sudo[8973]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:06 volumio volumio[8837]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 1 Jan 17 19:24:06 volumio volumio[8837]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 2 Jan 17 19:24:06 volumio volumio[8837]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:24:06 volumio volumio[8837]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:24:06 volumio volumio[8837]: info: CoreStateMachine::pushState Jan 17 19:24:06 volumio volumio[8837]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:06 volumio volumio[8837]: info: CoreStateMachine::updateTrackBlock Jan 17 19:24:06 volumio volumio[8837]: info: CorePlayQueue::getTrackBlock Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:24:06 volumio volumio[8837]: info: CoreStateMachine::setRepeat null single undefined Jan 17 19:24:06 volumio volumio[8837]: info: CoreStateMachine::pushState Jan 17 19:24:06 volumio volumio[8837]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:06 volumio volumio[8837]: info: CoreStateMachine::setRandom null Jan 17 19:24:06 volumio volumio[8837]: info: CoreStateMachine::pushState Jan 17 19:24:06 volumio volumio[8837]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:06 volumio volumio[8837]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:24:06 volumio volumio[8837]: info: CoreStateMachine::pushState Jan 17 19:24:06 volumio volumio[8837]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:06 volumio volumio[8837]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:24:06 volumio volumio[8837]: info: Output device has changed, restarting MPD Jan 17 19:24:06 volumio sudo[8984]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start upmpdcli.service Jan 17 19:24:06 volumio sudo[8984]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio sudo[8984]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:06 volumio volumio[8837]: info: Output device has changed, restarting Shairport Sync Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:06 volumio sudo[8987]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:06 volumio sudo[8987]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio sudo[8987]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:06 volumio sudo[8989]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:06 volumio sudo[8989]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 19:24:06 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:06 volumio volumio[8837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:06 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:06 volumio volumio[8837]: info: ___________ START PLUGINS ___________ Jan 17 19:24:06 volumio volumio[8837]: info: ControllerMpd::onStart: Initializing MPD Jan 17 19:24:06 volumio volumio[8837]: info: Creating MPD Configuration file Jan 17 19:24:06 volumio sudo[8997]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:06 volumio volumio[8837]: info: [1737138246853] CoreMusicLibrary::Adding element Serwery Mediów Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:06 volumio sudo[8997]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:06 volumio sudo[8997]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:06 volumio sudo[8999]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:06 volumio sudo[8999]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 17 19:24:06 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:06 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:06 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:06 volumio volumio[8837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:06 volumio volumio[8837]: info: [1737138246894] CoreMusicLibrary::Adding element Last_100 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:06 volumio volumio[8837]: info: [1737138246896] CoreMusicLibrary::Adding element Webradio Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:06 volumio sudo[9003]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:24:06 volumio sudo[9003]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:06 volumio volumio[8837]: info: Initializing BBC Radios Jan 17 19:24:06 volumio sudo[9003]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: Loading i18n strings for locale pl Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: FusionDsp - mixtype--------------------- Hardware Jan 17 19:24:06 volumio volumio[8837]: info: Volumio Calling Home Jan 17 19:24:06 volumio volumio[8837]: info: Preparing to generate the ALSA configuration file Jan 17 19:24:06 volumio volumio[8837]: info: Discovery: adding db590945-5fbf-4bfa-8882-0bd01dc22477 Jan 17 19:24:06 volumio volumio[8837]: info: Discovery: Found device Volumio Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:06 volumio volumio[8837]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:06 volumio volumio[8837]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:24:06 volumio volumio[8837]: info: Reading ALSA contributions from plugins. Jan 17 19:24:06 volumio volumio[8837]: info: MPD Permissions set Jan 17 19:24:06 volumio volumio[8837]: info: MPD Permissions set Jan 17 19:24:06 volumio volumio[8837]: info: Upmpdcli Daemon Started Jan 17 19:24:06 volumio volumio[8837]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 4 Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:06 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: Starting Shairport Sync Jan 17 19:24:07 volumio volumio[8837]: info: Starting Shairport Sync Jan 17 19:24:07 volumio volumio[8837]: info: Starting Shairport Sync Jan 17 19:24:07 volumio sudo[9037]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:07 volumio sudo[9037]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:07 volumio sudo[9039]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:07 volumio sudo[9039]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:07 volumio sudo[9044]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:07 volumio sudo[9044]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:07 volumio volumio[8837]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:07 volumio volumio[8837]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:24:07 volumio volumio[8837]: info: Output device has changed, restarting MPD Jan 17 19:24:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:07 volumio sudo[9047]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:07 volumio sudo[9047]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:07 volumio sudo[9047]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio sudo[9037]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:07 volumio volumio[8837]: info: Output device has changed, restarting Shairport Sync Jan 17 19:24:07 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:07 volumio sudo[9039]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio sudo[9044]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio sudo[9051]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:07 volumio sudo[9051]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:07 volumio volumio[8837]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:07 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 19:24:07 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:07 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:07 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:07 volumio volumio[8837]: info: MPD Permissions set Jan 17 19:24:07 volumio volumio[8837]: info: Shairport-Sync Started Jan 17 19:24:07 volumio volumio[8837]: Error adding Membership: Error: addMembership EINVAL Jan 17 19:24:07 volumio volumio[8837]: info: Shairport-Sync Started Jan 17 19:24:07 volumio volumio[8837]: info: Shairport-Sync Started Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:07 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:07 volumio volumio[8837]: info: Starting Shairport Sync Jan 17 19:24:07 volumio sudo[9059]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:24:07 volumio sudo[9059]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:07 volumio sudo[9059]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio sudo[9069]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:07 volumio sudo[9069]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:07 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:07 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:07 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:07 volumio volumio[8837]: info: Volumio called home Jan 17 19:24:07 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:07 volumio sudo[9069]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio volumio[8837]: info: Shairport-Sync Started Jan 17 19:24:07 volumio mpd[9068]: Jan 17 19:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:24:07 volumio systemd[1]: Started Music Player Daemon. Jan 17 19:24:07 volumio sudo[8989]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio sudo[8999]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio sudo[9051]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:07 volumio volumio[8837]: info: Completed starting Core Plugins Jan 17 19:24:07 volumio volumio[8837]: info: ------------------------------------------- Jan 17 19:24:07 volumio volumio[8837]: info: ----- MyVolumio plugins startup ---- Jan 17 19:24:07 volumio volumio[8837]: info: ------------------------------------------- Jan 17 19:24:07 volumio volumio[8837]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 17 19:24:07 volumio volumio[8837]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:24:07 volumio volumio[8837]: assert.ok(self.idling) Jan 17 19:24:07 volumio volumio[8837]: error: The expression evaluated to a falsy value: Jan 17 19:24:07 volumio volumio[8837]: assert.ok(self.idling) Jan 17 19:24:07 volumio volumio[8837]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:24:07 volumio volumio[8837]: assert.ok(self.idling) Jan 17 19:24:07 volumio volumio[8837]: error: The expression evaluated to a falsy value: Jan 17 19:24:07 volumio volumio[8837]: assert.ok(self.idling) Jan 17 19:24:07 volumio volumio[8837]: info: MPD running with PID9068 Jan 17 19:24:07 volumio volumio[8837]: ,establishing connection Jan 17 19:24:07 volumio volumio[8837]: error: updateQueue error: null Jan 17 19:24:07 volumio volumio[8837]: error: updateQueue error: null Jan 17 19:24:10 volumio volumio-remote-updater[794]: [2025-01-17 19:24:10] [connect] Successful connection Jan 17 19:24:11 volumio volumio[8837]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 17 19:24:11 volumio volumio[8837]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 6 Jan 17 19:24:11 volumio volumio[8837]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 7 Jan 17 19:24:11 volumio volumio[8837]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 8 Jan 17 19:24:11 volumio volumio[8837]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:24:11 volumio volumio[8837]: 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 Jan 17 19:24:11 volumio volumio[8837]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:24:11 volumio volumio[8837]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 19:24:11 volumio volumio[8837]: info: camilladsp service started and running in background, instance 1 Jan 17 19:24:11 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:11 volumio volumio[8837]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:24:11 volumio volumio[8837]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 17 19:24:11 volumio volumio[8837]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:24:11 volumio volumio[8837]: info: FusionDsp loaded Jan 17 19:24:11 volumio volumio[8837]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:24:11 volumio sudo[9093]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 19:24:11 volumio sudo[9093]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:11 volumio volumio[8837]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 19:24:11 volumio volumio[8837]: info: Adding Signal Path Element [object Object] Jan 17 19:24:11 volumio volumio[8837]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 19:24:11 volumio volumio[8837]: info: FusionDsp - ---- installed callbackRead Jan 17 19:24:11 volumio volumio[8837]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:24:11 volumio sudo[9093]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:11 volumio volumio[8837]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 19:24:11 volumio volumio[8837]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jan 17 19:24:11 volumio volumio[8837]: at onErrorNT (internal/child_process.js:472:16) Jan 17 19:24:11 volumio volumio[8837]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jan 17 19:24:11 volumio volumio[8837]: at runNextTicks (internal/process/task_queues.js:64:3) Jan 17 19:24:11 volumio volumio[8837]: at listOnTimeout (internal/timers.js:526:9) Jan 17 19:24:11 volumio volumio[8837]: at processTimers (internal/timers.js:500:7) { Jan 17 19:24:11 volumio volumio[8837]: errno: -2, Jan 17 19:24:11 volumio volumio[8837]: code: 'ENOENT', Jan 17 19:24:11 volumio volumio[8837]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:24:11 volumio volumio[8837]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:24:11 volumio volumio[8837]: spawnargs: [ Jan 17 19:24:11 volumio volumio[8837]: '-p', Jan 17 19:24:11 volumio volumio[8837]: 9876, Jan 17 19:24:11 volumio volumio[8837]: '-o', Jan 17 19:24:11 volumio volumio[8837]: '/tmp/camilladsp.log', Jan 17 19:24:11 volumio volumio[8837]: '-l', Jan 17 19:24:11 volumio volumio[8837]: 'warn', Jan 17 19:24:11 volumio volumio[8837]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 19:24:11 volumio volumio[8837]: ] Jan 17 19:24:11 volumio volumio[8837]: } Jan 17 19:24:11 volumio volumio[8837]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:24:11 volumio sudo[9104]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 19:23 Jan 17 19:24:11 volumio sudo[9104]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:11 volumio sudo[9104]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:11 volumio volumio-remote-updater[794]: [2025-01-17 19:24:11] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jan 17 19:24:11 volumio volumio-remote-updater[794]: [2025-01-17 19:24:11] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jan 17 19:24:11 volumio volumio-remote-updater[794]: [2025-01-17 19:24:11] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 17 19:24:11 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 17 19:24:11 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 17 19:24:11 volumio systemd[1]: Started dynamicswap service. Jan 17 19:24:11 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:24:11 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 17 19:24:11 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 26. Jan 17 19:24:11 volumio systemd[1]: Started dynamicswap service. Jan 17 19:24:11 volumio systemd[1]: Stopped Volumio Backend Module. Jan 17 19:24:11 volumio systemd[1]: Started Volumio Backend Module. Jan 17 19:24:11 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:24:12 volumio volumio[9115]: info: ------------------------------------------- Jan 17 19:24:12 volumio volumio[9115]: info: ----- Volumio3 ---- Jan 17 19:24:12 volumio volumio[9115]: info: ------------------------------------------- Jan 17 19:24:12 volumio volumio[9115]: info: ----- System startup ---- Jan 17 19:24:12 volumio volumio[9115]: info: ------------------------------------------- Jan 17 19:24:14 volumio volumio[9115]: info: MYVOLUMIO Environment detected Jan 17 19:24:14 volumio volumio[9115]: info: Plugin folders cleanup Jan 17 19:24:14 volumio volumio[9115]: info: Scanning into folder /volumio/app/plugins/ Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category audio_interface Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category miscellanea Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category music_service Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category plugins.json Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category system_controller Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category user_interface Jan 17 19:24:14 volumio volumio[9115]: info: Scanning into folder /data/plugins/ Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category audio_interface Jan 17 19:24:14 volumio volumio[9115]: info: Scanning category user_interface Jan 17 19:24:14 volumio volumio[9115]: info: Plugin folders cleanup completed Jan 17 19:24:14 volumio volumio[9115]: info: ------------------------------------------- Jan 17 19:24:14 volumio volumio[9115]: info: ----- Core plugins startup ---- Jan 17 19:24:14 volumio volumio[9115]: info: ------------------------------------------- Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 19:24:14 volumio volumio[9115]: info: Adding plugin upnp to MyMusic Plugins Jan 17 19:24:14 volumio volumio[9115]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 19:24:14 volumio volumio[9115]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugins from folder /data/plugins/ Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "system"... Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "appearance"... Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "network"... Jan 17 19:24:14 volumio volumio[9115]: info: Refreshing Cached IP Addresses Jan 17 19:24:14 volumio sudo[9141]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:24:14 volumio sudo[9141]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:14 volumio sudo[9141]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:14 volumio sudo[9143]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:24:14 volumio sudo[9143]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "services"... Jan 17 19:24:14 volumio sudo[9143]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "alsa_controller"... Jan 17 19:24:14 volumio sudo[9152]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 17 19:24:14 volumio sudo[9152]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:14 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "wizard"... Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "networkfs"... Jan 17 19:24:14 volumio volumio[9115]: info: Starting Udev Watcher for removable devices Jan 17 19:24:14 volumio volumio[9115]: info: Ignoring mount for partition: boot Jan 17 19:24:14 volumio volumio[9115]: info: Ignoring mount for partition: volumio Jan 17 19:24:14 volumio volumio[9115]: info: Ignoring mount for partition: volumio_data Jan 17 19:24:14 volumio volumio[9115]: info: Ignoring mount for partition: Zastrzeżone_przez_system Jan 17 19:24:14 volumio volumio[9115]: info: Ignoring mount for partition: B46AA8996AA859BE Jan 17 19:24:14 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "volumio_command_line_client"... Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "upnp"... Jan 17 19:24:14 volumio volumio[9115]: info: [1737138254964] Starting Upmpd Daemon Jan 17 19:24:14 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "my_music"... Jan 17 19:24:14 volumio volumio[9115]: info: Loading plugin "mpd"... Jan 17 19:24:15 volumio volumio[9115]: info: Loading plugin "upnp_browser"... Jan 17 19:24:15 volumio volumio[9115]: info: Loading plugin "alarm-clock"... Jan 17 19:24:15 volumio volumio[9115]: info: Loading plugin "airplay_emulation"... Jan 17 19:24:15 volumio volumio[9115]: info: Starting Shairport Sync Jan 17 19:24:15 volumio volumio[9115]: info: Loading plugin "last_100"... Jan 17 19:24:15 volumio volumio[9115]: info: Loading plugin "webradio"... Jan 17 19:24:15 volumio volumio[9115]: info: Loading plugin "i2s_dacs"... Jan 17 19:24:15 volumio volumio[9115]: info: I2S DAC not set, start Auto-detection Jan 17 19:24:15 volumio volumio[9115]: info: Loading plugin "volumiodiscovery"... Jan 17 19:24:15 volumio volumio[9115]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:15 volumio volumio[9115]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:15 volumio volumio[9115]: *** WARNING *** For more information see Jan 17 19:24:15 volumio volumio[9115]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:15 volumio volumio[9115]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:15 volumio volumio[9115]: *** WARNING *** For more information see Jan 17 19:24:15 volumio node[9115]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:15 volumio node[9115]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:15 volumio node[9115]: *** WARNING *** For more information see Jan 17 19:24:15 volumio node[9115]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:15 volumio node[9115]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:15 volumio node[9115]: *** WARNING *** For more information see Jan 17 19:24:15 volumio volumio[9115]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 19:24:17 volumio sudo[9152]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:17 volumio volumio[9115]: info: Discovery: Started advertising with name: Volumio Jan 17 19:24:17 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:24:17 volumio volumio[9115]: info: Plugin now_playing is not enabled Jan 17 19:24:17 volumio volumio[9115]: info: Loading plugin "outputs"... Jan 17 19:24:17 volumio volumio[9115]: info: Loading plugin "albumart"... Jan 17 19:24:17 volumio volumio[9115]: info: Plugin example_plugin is not enabled Jan 17 19:24:17 volumio volumio[9115]: info: Loading plugin "inputs"... Jan 17 19:24:17 volumio volumio[9115]: info: Loading plugin "updater_comm"... Jan 17 19:24:17 volumio volumio[9115]: info: Plugin mpdemulation is not enabled Jan 17 19:24:17 volumio volumio[9115]: info: Loading plugin "rest_api"... Jan 17 19:24:17 volumio volumio[9115]: info: Loading plugin "websocket"... Jan 17 19:24:17 volumio volumio[9115]: info: Starting Socket.io Server version 2.3.0 Jan 17 19:24:17 volumio volumio[9115]: info: Loading plugin "fusiondsp"... Jan 17 19:24:17 volumio volumio[9115]: Forking 3 albumart workers Jan 17 19:24:18 volumio volumio[9115]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 19:24:18 volumio volumio[9115]: info: Loading i18n strings for locale pl Jan 17 19:24:18 volumio volumio[9115]: Updating browse sources language Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::initPlayerControls Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: Express server listening on port 3000 Jan 17 19:24:18 volumio volumio[9115]: [Metrics] WebUI: 6s 148.17ms Jan 17 19:24:18 volumio volumio[9115]: info: Setting Device type: x86 Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::resetVolumioState Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::getcurrentVolume Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:24:18 volumio volumio[9115]: Starting albumart workers Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: Starting albumart workers Jan 17 19:24:18 volumio volumio[9115]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 17 19:24:18 volumio volumio[9115]: info: Completed loading Core Plugins Jan 17 19:24:18 volumio volumio[9115]: info: Preparing to generate the ALSA configuration file Jan 17 19:24:18 volumio volumio[9115]: Starting albumart workers Jan 17 19:24:18 volumio volumio[9115]: info: Cannot read play queue from file Jan 17 19:24:18 volumio volumio[9115]: info: Volumio Network Manager: Network status updated: 2 Jan 17 19:24:18 volumio volumio[9115]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 17 19:24:18 volumio volumio[9115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:24:18 volumio volumio[9115]: info: Reading ALSA contributions from plugins. Jan 17 19:24:18 volumio volumio[9115]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 1 Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::setRepeat null single undefined Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::pushState Jan 17 19:24:18 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::setRandom null Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::pushState Jan 17 19:24:18 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:18 volumio volumio[9115]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::pushState Jan 17 19:24:18 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::updateTrackBlock Jan 17 19:24:18 volumio volumio[9115]: info: CorePlayQueue::getTrackBlock Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:24:18 volumio volumio[9115]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:24:18 volumio volumio[9115]: info: Output device has changed, restarting MPD Jan 17 19:24:18 volumio volumio[9115]: info: Output device has changed, restarting Shairport Sync Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio sudo[9212]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:18 volumio sudo[9212]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio sudo[9214]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:18 volumio sudo[9214]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio sudo[9212]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 19:24:18 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:18 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:18 volumio volumio[9115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:18 volumio volumio[9115]: info: ___________ START PLUGINS ___________ Jan 17 19:24:18 volumio volumio[9115]: info: ControllerMpd::onStart: Initializing MPD Jan 17 19:24:18 volumio volumio[9115]: info: Creating MPD Configuration file Jan 17 19:24:18 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:18 volumio sudo[9246]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:18 volumio sudo[9246]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:18 volumio volumio[9115]: info: [1737138258383] CoreMusicLibrary::Adding element Serwery Mediów Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:18 volumio sudo[9246]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio sudo[9248]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:18 volumio sudo[9248]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 17 19:24:18 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:18 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:18 volumio volumio[9115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:18 volumio sudo[9251]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:24:18 volumio sudo[9251]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio volumio[9115]: info: [1737138258418] CoreMusicLibrary::Adding element Last_100 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:18 volumio volumio[9115]: info: [1737138258420] CoreMusicLibrary::Adding element Webradio Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:18 volumio sudo[9251]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:18 volumio volumio[9115]: info: Initializing BBC Radios Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: Loading i18n strings for locale pl Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: FusionDsp - mixtype--------------------- Hardware Jan 17 19:24:18 volumio volumio[9115]: info: Volumio Calling Home Jan 17 19:24:18 volumio volumio[9115]: info: Preparing to generate the ALSA configuration file Jan 17 19:24:18 volumio volumio[9115]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:24:18 volumio volumio[9115]: info: Reading ALSA contributions from plugins. Jan 17 19:24:18 volumio volumio[9115]: info: MPD Permissions set Jan 17 19:24:18 volumio volumio[9115]: info: MPD Permissions set Jan 17 19:24:18 volumio volumio[9115]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 2 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:24:18 volumio volumio[9115]: info: CoreStateMachine::pushState Jan 17 19:24:18 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:18 volumio volumio[9115]: info: Starting Shairport Sync Jan 17 19:24:18 volumio volumio[9115]: info: Starting Shairport Sync Jan 17 19:24:18 volumio volumio[9115]: info: Starting Shairport Sync Jan 17 19:24:18 volumio sudo[9287]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:18 volumio sudo[9287]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio sudo[9289]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:18 volumio sudo[9289]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:18 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:18 volumio sudo[9293]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:18 volumio sudo[9293]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:18 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:18 volumio volumio[9115]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:24:18 volumio volumio[9115]: info: Output device has changed, restarting MPD Jan 17 19:24:18 volumio volumio[9115]: info: Output device has changed, restarting Shairport Sync Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:18 volumio sudo[9297]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:18 volumio sudo[9297]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio sudo[9299]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:18 volumio sudo[9299]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:18 volumio systemd[1]: shairport-sync.service: Main process exited, code=killed, status=15/TERM Jan 17 19:24:18 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:18 volumio sudo[9287]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio sudo[9297]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:18 volumio volumio[9115]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:18 volumio sudo[9289]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 19:24:18 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:18 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:18 volumio sudo[9293]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio volumio[9115]: info: MPD Permissions set Jan 17 19:24:18 volumio volumio[9115]: info: Shairport-Sync Started Jan 17 19:24:18 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:18 volumio volumio[9115]: Error adding Membership: Error: addMembership EINVAL Jan 17 19:24:18 volumio volumio[9115]: info: Shairport-Sync Started Jan 17 19:24:18 volumio volumio[9115]: info: Shairport-Sync Started Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:18 volumio volumio[9115]: info: Starting Shairport Sync Jan 17 19:24:18 volumio sudo[9306]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:24:18 volumio sudo[9306]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio sudo[9306]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio sudo[9316]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:18 volumio sudo[9316]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:18 volumio volumio[9115]: info: Volumio called home Jan 17 19:24:18 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:18 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:18 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:18 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:18 volumio sudo[9316]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio volumio[9115]: info: Shairport-Sync Started Jan 17 19:24:18 volumio volumio[9115]: info: Discovery: adding db590945-5fbf-4bfa-8882-0bd01dc22477 Jan 17 19:24:18 volumio volumio[9115]: info: Discovery: Found device Volumio Jan 17 19:24:18 volumio volumio[9115]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:18 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:18 volumio mpd[9318]: Jan 17 19:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:24:18 volumio systemd[1]: Started Music Player Daemon. Jan 17 19:24:18 volumio sudo[9248]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio sudo[9214]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio sudo[9299]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:18 volumio volumio[9115]: info: Completed starting Core Plugins Jan 17 19:24:18 volumio volumio[9115]: info: ------------------------------------------- Jan 17 19:24:18 volumio volumio[9115]: info: ----- MyVolumio plugins startup ---- Jan 17 19:24:18 volumio volumio[9115]: info: ------------------------------------------- Jan 17 19:24:18 volumio volumio[9115]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 17 19:24:18 volumio volumio[9115]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:24:18 volumio volumio[9115]: assert.ok(self.idling) Jan 17 19:24:18 volumio volumio[9115]: error: The expression evaluated to a falsy value: Jan 17 19:24:18 volumio volumio[9115]: assert.ok(self.idling) Jan 17 19:24:18 volumio volumio[9115]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:24:18 volumio volumio[9115]: assert.ok(self.idling) Jan 17 19:24:18 volumio volumio[9115]: error: The expression evaluated to a falsy value: Jan 17 19:24:18 volumio volumio[9115]: assert.ok(self.idling) Jan 17 19:24:18 volumio volumio[9115]: info: MPD running with PID9318 Jan 17 19:24:18 volumio volumio[9115]: ,establishing connection Jan 17 19:24:18 volumio volumio[9115]: error: updateQueue error: null Jan 17 19:24:18 volumio volumio[9115]: error: updateQueue error: null Jan 17 19:24:19 volumio volumio[9115]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:19 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 17 19:24:19 volumio volumio[9115]: info: Received Get System Info Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 19:24:19 volumio volumio[9115]: info: Discovery: Getting this device information Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:19 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:19 volumio volumio[9115]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:19 volumio volumio[9115]: info: Listing playlists Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:19 volumio volumio[9115]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:21 volumio ntpd[1167]: 80.68.234.117 local addr 192.168.169.7 -> Jan 17 19:24:21 volumio volumio-remote-updater[794]: [2025-01-17 19:24:21] [connect] Successful connection Jan 17 19:24:22 volumio volumio[9115]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 4 Jan 17 19:24:22 volumio volumio[9115]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 5 Jan 17 19:24:22 volumio volumio[9115]: verbose: New Socket.io Connection to 192.168.169.7:3000 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 6 Jan 17 19:24:22 volumio volumio[9115]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:24:22 volumio volumio[9115]: 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 Jan 17 19:24:22 volumio volumio[9115]: /usr/bin/mkfifo: cannot create fifo '/tmp/fusiondspfifo': File exists Jan 17 19:24:22 volumio volumio[9115]: info: camilladsp spawned new process with pid undefined, instance 1, run: true Jan 17 19:24:22 volumio volumio[9115]: info: camilladsp service started and running in background, instance 1 Jan 17 19:24:22 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:22 volumio volumio[9115]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:24:22 volumio volumio[9115]: error: FusionDsp - ----Hw detection failed :Error: Command failed: /data/plugins/audio_interface/fusiondsp/hw_params volumioHw >/data/configuration/audio_interface/fusiondsp/hwinfo.json Jan 17 19:24:22 volumio volumio[9115]: /bin/sh: 1: /data/plugins/audio_interface/fusiondsp/hw_params: not found Jan 17 19:24:22 volumio volumio[9115]: info: FusionDsp loaded Jan 17 19:24:22 volumio volumio[9115]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:24:22 volumio sudo[9342]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl start fusiondsp.service Jan 17 19:24:22 volumio sudo[9342]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:22 volumio volumio[9115]: info: FusionDsp - Reporting Fusion DSP Enabled Jan 17 19:24:22 volumio volumio[9115]: info: Adding Signal Path Element [object Object] Jan 17 19:24:22 volumio volumio[9115]: info: Adding fusiondspeq DSP Signal Path Element Jan 17 19:24:22 volumio volumio[9115]: info: FusionDsp - ---- installed callbackRead Jan 17 19:24:22 volumio volumio[9115]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:24:22 volumio sudo[9342]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:22 volumio volumio[9115]: Error: spawn /data/plugins/audio_interface/fusiondsp/camilladsp ENOENT Jan 17 19:24:22 volumio volumio[9115]: at Process.ChildProcess._handle.onexit (internal/child_process.js:277:19) Jan 17 19:24:22 volumio volumio[9115]: at onErrorNT (internal/child_process.js:472:16) Jan 17 19:24:22 volumio volumio[9115]: at processTicksAndRejections (internal/process/task_queues.js:82:21) Jan 17 19:24:22 volumio volumio[9115]: at runNextTicks (internal/process/task_queues.js:64:3) Jan 17 19:24:22 volumio volumio[9115]: at listOnTimeout (internal/timers.js:526:9) Jan 17 19:24:22 volumio volumio[9115]: at processTimers (internal/timers.js:500:7) { Jan 17 19:24:22 volumio volumio[9115]: errno: -2, Jan 17 19:24:22 volumio volumio[9115]: code: 'ENOENT', Jan 17 19:24:22 volumio volumio[9115]: syscall: 'spawn /data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:24:22 volumio volumio[9115]: path: '/data/plugins/audio_interface/fusiondsp/camilladsp', Jan 17 19:24:22 volumio volumio[9115]: spawnargs: [ Jan 17 19:24:22 volumio volumio[9115]: '-p', Jan 17 19:24:22 volumio volumio[9115]: 9876, Jan 17 19:24:22 volumio volumio[9115]: '-o', Jan 17 19:24:22 volumio volumio[9115]: '/tmp/camilladsp.log', Jan 17 19:24:22 volumio volumio[9115]: '-l', Jan 17 19:24:22 volumio volumio[9115]: 'warn', Jan 17 19:24:22 volumio volumio[9115]: '/data/configuration/audio_interface/fusiondsp/camilladsp.yml' Jan 17 19:24:22 volumio volumio[9115]: ] Jan 17 19:24:22 volumio volumio[9115]: } Jan 17 19:24:22 volumio volumio[9115]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:24:22 volumio sudo[9353]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 19:23 Jan 17 19:24:22 volumio sudo[9353]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:22 volumio sudo[9353]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:22 volumio volumio-remote-updater[794]: [2025-01-17 19:24:22] [info] asio async_read_at_least error: system:104 (Connection reset by peer) Jan 17 19:24:22 volumio volumio-remote-updater[794]: [2025-01-17 19:24:22] [error] handle_read_http_response error: websocketpp.transport:2 (Underlying Transport Error) Jan 17 19:24:22 volumio volumio-remote-updater[794]: [2025-01-17 19:24:22] [info] Error getting remote endpoint: system:107 (Transport endpoint is not connected) Jan 17 19:24:22 volumio systemd[1]: volumio.service: Main process exited, code=exited, status=1/FAILURE Jan 17 19:24:22 volumio systemd[1]: volumio.service: Failed with result 'exit-code'. Jan 17 19:24:22 volumio systemd[1]: Started dynamicswap service. Jan 17 19:24:22 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:24:23 volumio systemd[1]: volumio.service: Service RestartSec=100ms expired, scheduling restart. Jan 17 19:24:23 volumio systemd[1]: volumio.service: Scheduled restart job, restart counter is at 27. Jan 17 19:24:23 volumio systemd[1]: Stopped Volumio Backend Module. Jan 17 19:24:23 volumio systemd[1]: Started Volumio Backend Module. Jan 17 19:24:23 volumio systemd[1]: Started dynamicswap service. Jan 17 19:24:23 volumio systemd[1]: dynamicswap.service: Succeeded. Jan 17 19:24:23 volumio volumio[9363]: info: ------------------------------------------- Jan 17 19:24:23 volumio volumio[9363]: info: ----- Volumio3 ---- Jan 17 19:24:23 volumio volumio[9363]: info: ------------------------------------------- Jan 17 19:24:23 volumio volumio[9363]: info: ----- System startup ---- Jan 17 19:24:23 volumio volumio[9363]: info: ------------------------------------------- Jan 17 19:24:26 volumio volumio[9363]: info: MYVOLUMIO Environment detected Jan 17 19:24:26 volumio volumio[9363]: info: Plugin folders cleanup Jan 17 19:24:26 volumio volumio[9363]: info: Scanning into folder /volumio/app/plugins/ Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category audio_interface Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category miscellanea Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category music_service Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category plugins.json Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category system_controller Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category user_interface Jan 17 19:24:26 volumio volumio[9363]: info: Scanning into folder /data/plugins/ Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category audio_interface Jan 17 19:24:26 volumio volumio[9363]: info: Scanning category user_interface Jan 17 19:24:26 volumio volumio[9363]: info: Plugin folders cleanup completed Jan 17 19:24:26 volumio volumio[9363]: info: ------------------------------------------- Jan 17 19:24:26 volumio volumio[9363]: info: ----- Core plugins startup ---- Jan 17 19:24:26 volumio volumio[9363]: info: ------------------------------------------- Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugins from folder /volumio/app/plugins/ Jan 17 19:24:26 volumio volumio[9363]: info: Adding plugin upnp to MyMusic Plugins Jan 17 19:24:26 volumio volumio[9363]: info: Adding plugin airplay_emulation to MyMusic Plugins Jan 17 19:24:26 volumio volumio[9363]: info: Adding plugin upnp_browser to MyMusic Plugins Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugins from folder /data/plugins/ Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "system"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "appearance"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "network"... Jan 17 19:24:26 volumio volumio[9363]: info: Refreshing Cached IP Addresses Jan 17 19:24:26 volumio sudo[9390]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig eth0 Jan 17 19:24:26 volumio sudo[9390]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:26 volumio sudo[9392]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/ifconfig wlan0 Jan 17 19:24:26 volumio sudo[9390]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:26 volumio sudo[9392]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:26 volumio sudo[9392]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "services"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "alsa_controller"... Jan 17 19:24:26 volumio sudo[9401]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/sbin/iwlist wlan0 scan Jan 17 19:24:26 volumio sudo[9401]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "wizard"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "networkfs"... Jan 17 19:24:26 volumio volumio[9363]: info: Starting Udev Watcher for removable devices Jan 17 19:24:26 volumio volumio[9363]: info: Ignoring mount for partition: boot Jan 17 19:24:26 volumio volumio[9363]: info: Ignoring mount for partition: volumio Jan 17 19:24:26 volumio volumio[9363]: info: Ignoring mount for partition: volumio_data Jan 17 19:24:26 volumio volumio[9363]: info: Ignoring mount for partition: Zastrzeżone_przez_system Jan 17 19:24:26 volumio volumio[9363]: info: Ignoring mount for partition: B46AA8996AA859BE Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "volumio_command_line_client"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "upnp"... Jan 17 19:24:26 volumio volumio[9363]: info: [1737138266517] Starting Upmpd Daemon Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "my_music"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "mpd"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "upnp_browser"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "alarm-clock"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "airplay_emulation"... Jan 17 19:24:26 volumio volumio[9363]: info: Starting Shairport Sync Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "last_100"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "webradio"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "i2s_dacs"... Jan 17 19:24:26 volumio volumio[9363]: info: I2S DAC not set, start Auto-detection Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "volumiodiscovery"... Jan 17 19:24:26 volumio volumio[9363]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:26 volumio volumio[9363]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:26 volumio volumio[9363]: *** WARNING *** For more information see Jan 17 19:24:26 volumio volumio[9363]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:26 volumio volumio[9363]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:26 volumio volumio[9363]: *** WARNING *** For more information see Jan 17 19:24:26 volumio node[9363]: *** WARNING *** The program 'node' uses the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:26 volumio node[9363]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:26 volumio node[9363]: *** WARNING *** For more information see Jan 17 19:24:26 volumio node[9363]: *** WARNING *** The program 'node' called 'DNSServiceRegister()' which is not supported (or only supported partially) in the Apple Bonjour compatibility layer of Avahi. Jan 17 19:24:26 volumio node[9363]: *** WARNING *** Please fix your application to use the native API of Avahi! Jan 17 19:24:26 volumio node[9363]: *** WARNING *** For more information see Jan 17 19:24:26 volumio volumio[9363]: info: Applying required configuration parameters for plugin volumiodiscovery Jan 17 19:24:26 volumio volumio[9363]: info: Discovery: Started advertising with name: Volumio Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , registerCallback Jan 17 19:24:26 volumio volumio[9363]: info: Plugin now_playing is not enabled Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "outputs"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "albumart"... Jan 17 19:24:26 volumio volumio[9363]: info: Plugin example_plugin is not enabled Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "inputs"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "updater_comm"... Jan 17 19:24:26 volumio volumio[9363]: info: Plugin mpdemulation is not enabled Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "rest_api"... Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "websocket"... Jan 17 19:24:26 volumio volumio[9363]: info: Starting Socket.io Server version 2.3.0 Jan 17 19:24:26 volumio volumio[9363]: info: Loading plugin "fusiondsp"... Jan 17 19:24:26 volumio volumio[9363]: Forking 3 albumart workers Jan 17 19:24:26 volumio volumio[9363]: info: Applying required configuration parameters for plugin fusiondsp Jan 17 19:24:26 volumio volumio[9363]: info: Loading i18n strings for locale pl Jan 17 19:24:26 volumio volumio[9363]: Updating browse sources language Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::initPlayerControls Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: Express server listening on port 3000 Jan 17 19:24:26 volumio volumio[9363]: [Metrics] WebUI: 3s 697.78ms Jan 17 19:24:26 volumio volumio[9363]: info: Setting Device type: x86 Jan 17 19:24:26 volumio volumio[9363]: info: CoreStateMachine::resetVolumioState Jan 17 19:24:26 volumio volumio[9363]: info: CoreStateMachine::getcurrentVolume Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:24:26 volumio volumio[9363]: Starting albumart workers Jan 17 19:24:26 volumio volumio[9363]: Starting albumart workers Jan 17 19:24:26 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:26 volumio volumio[9363]: error: Cannot read config.txt file: Error: ENOENT: no such file or directory, open '/boot/config.txt' Jan 17 19:24:26 volumio volumio[9363]: info: Completed loading Core Plugins Jan 17 19:24:26 volumio volumio[9363]: info: Preparing to generate the ALSA configuration file Jan 17 19:24:26 volumio volumio[9363]: Starting albumart workers Jan 17 19:24:26 volumio volumio[9363]: info: Cannot read play queue from file Jan 17 19:24:27 volumio volumio[9363]: info: Volumio Network Manager: Network status updated: 2 Jan 17 19:24:27 volumio volumio[9363]: info: Cannot read proc/cpuinfo: Error: Command failed: cat /proc/cpuinfo | grep Revision Jan 17 19:24:27 volumio volumio[9363]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:24:27 volumio volumio[9363]: info: Reading ALSA contributions from plugins. Jan 17 19:24:27 volumio volumio[9363]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 1 Jan 17 19:24:27 volumio volumio[9363]: verbose: New Socket.io Connection to 192.168.169.7 from 192.168.169.2 UA: Mozilla/5.0 (Windows NT 6.1; Win64; x64; rv:109.0) Gecko/20100101 Firefox/115.0 Engine version: 3 Transport: polling Total Clients: 2 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: my_volumio , getAutoUpdateCheckEnabled Jan 17 19:24:27 volumio volumio[9363]: info: CoreStateMachine::setRepeat null single undefined Jan 17 19:24:27 volumio volumio[9363]: info: CoreStateMachine::pushState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:27 volumio volumio[9363]: info: CoreStateMachine::setRandom null Jan 17 19:24:27 volumio volumio[9363]: info: CoreStateMachine::pushState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:27 volumio volumio[9363]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:24:27 volumio volumio[9363]: info: CoreStateMachine::pushState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:27 volumio volumio[9363]: info: CoreStateMachine::updateTrackBlock Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrackBlock Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioRetrievevolume Jan 17 19:24:27 volumio volumio[9363]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:24:27 volumio volumio[9363]: info: Output device has changed, restarting MPD Jan 17 19:24:27 volumio sudo[9469]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:27 volumio sudo[9469]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio volumio[9363]: info: Output device has changed, restarting Shairport Sync Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio sudo[9469]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio sudo[9480]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:27 volumio sudo[9480]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio systemd[1]: Stopping Music Player Daemon... Jan 17 19:24:27 volumio volumio[9363]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:27 volumio volumio[9363]: info: ___________ START PLUGINS ___________ Jan 17 19:24:27 volumio volumio[9363]: info: ControllerMpd::onStart: Initializing MPD Jan 17 19:24:27 volumio volumio[9363]: info: Creating MPD Configuration file Jan 17 19:24:27 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:27 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:27 volumio sudo[9495]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:27 volumio sudo[9495]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:27 volumio volumio[9363]: info: [1737138267188] CoreMusicLibrary::Adding element Serwery Mediów Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio sudo[9495]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:27 volumio sudo[9498]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:27 volumio sudo[9498]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio systemd[1]: mpd.service: Control process exited, code=killed, status=15/TERM Jan 17 19:24:27 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:27 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:27 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:27 volumio volumio[9363]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:27 volumio volumio[9363]: info: [1737138267228] CoreMusicLibrary::Adding element Last_100 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Jan 17 19:24:27 volumio volumio[9363]: info: [1737138267229] CoreMusicLibrary::Adding element Webradio Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:27 volumio volumio[9363]: info: Initializing BBC Radios Jan 17 19:24:27 volumio sudo[9503]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:24:27 volumio sudo[9503]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio sudo[9503]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: Loading i18n strings for locale pl Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: FusionDsp - mixtype--------------------- Hardware Jan 17 19:24:27 volumio volumio[9363]: info: Volumio Calling Home Jan 17 19:24:27 volumio volumio[9363]: info: Preparing to generate the ALSA configuration file Jan 17 19:24:27 volumio volumio[9363]: info: The plugin fusiondsp has an ALSA contribution file volumioDsp.postDsp.10.conf Jan 17 19:24:27 volumio volumio[9363]: info: Reading ALSA contributions from plugins. Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioGetVisibleSources Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: metavolumio , getInfinityPlayback Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: multiroom , getMultiroom Jan 17 19:24:27 volumio volumio[9363]: info: Received Get System Info Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Jan 17 19:24:27 volumio volumio[9363]: info: Discovery: Getting this device information Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio volumio[9363]: info: Listing playlists Jan 17 19:24:27 volumio volumio[9363]: info: MPD Permissions set Jan 17 19:24:27 volumio volumio[9363]: info: MPD Permissions set Jan 17 19:24:27 volumio volumio[9363]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 3 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: VolumeController:: Volume=41 Mute =false Jan 17 19:24:27 volumio volumio[9363]: info: CoreStateMachine::pushState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioPushState Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:27 volumio volumio[9363]: info: Starting Shairport Sync Jan 17 19:24:27 volumio volumio[9363]: info: Starting Shairport Sync Jan 17 19:24:27 volumio sudo[9536]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:27 volumio sudo[9536]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio volumio[9363]: info: Starting Shairport Sync Jan 17 19:24:27 volumio sudo[9539]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:27 volumio sudo[9539]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:27 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::getUIConfigOnPlugin Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:27 volumio sudo[9542]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:27 volumio sudo[9542]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio volumio[9363]: info: Asound.conf file unchanged, so no further update is needed Jan 17 19:24:27 volumio volumio[9363]: info: Output device has changed, restarting MPD Jan 17 19:24:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:27 volumio sudo[9536]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio volumio[9363]: info: Output device has changed, restarting Shairport Sync Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:27 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:27 volumio sudo[9546]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Jan 17 19:24:27 volumio sudo[9546]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio systemd[1]: Started Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:27 volumio sudo[9549]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Jan 17 19:24:27 volumio sudo[9549]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio sudo[9546]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio sudo[9539]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio sudo[9542]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio volumio[9363]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Jan 17 19:24:27 volumio systemd[1]: mpd.service: Main process exited, code=killed, status=15/TERM Jan 17 19:24:27 volumio systemd[1]: mpd.service: Succeeded. Jan 17 19:24:27 volumio systemd[1]: Stopped Music Player Daemon. Jan 17 19:24:27 volumio systemd[1]: Starting Music Player Daemon... Jan 17 19:24:27 volumio sudo[9557]: root : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Jan 17 19:24:27 volumio sudo[9557]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio sudo[9557]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio volumio[9363]: info: MPD Permissions set Jan 17 19:24:27 volumio volumio[9363]: info: Shairport-Sync Started Jan 17 19:24:27 volumio volumio[9363]: Error adding Membership: Error: addMembership EINVAL Jan 17 19:24:27 volumio volumio[9363]: info: Shairport-Sync Started Jan 17 19:24:27 volumio volumio[9363]: info: Shairport-Sync Started Jan 17 19:24:27 volumio mpd[9560]: Jan 17 19:24 : decoder: Decoder plugin 'wildmidi' is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Jan 17 19:24:27 volumio systemd[1]: Started Music Player Daemon. Jan 17 19:24:27 volumio sudo[9498]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio sudo[9480]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio sudo[9549]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio volumio[9363]: info: Volumio called home Jan 17 19:24:27 volumio volumio[9363]: info: Completed starting Core Plugins Jan 17 19:24:27 volumio volumio[9363]: info: ------------------------------------------- Jan 17 19:24:27 volumio volumio[9363]: info: ----- MyVolumio plugins startup ---- Jan 17 19:24:27 volumio volumio[9363]: info: ------------------------------------------- Jan 17 19:24:27 volumio volumio[9363]: info: [MyVolumio PluginManager] Fetching plans data.... Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: system , getCPUCoresNumber Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Jan 17 19:24:27 volumio volumio[9363]: info: MPD running with PID9560 Jan 17 19:24:27 volumio volumio[9363]: ,establishing connection Jan 17 19:24:27 volumio volumio[9363]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:24:27 volumio volumio[9363]: assert.ok(self.idling) Jan 17 19:24:27 volumio volumio[9363]: error: The expression evaluated to a falsy value: Jan 17 19:24:27 volumio volumio[9363]: assert.ok(self.idling) Jan 17 19:24:27 volumio volumio[9363]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:24:27 volumio volumio[9363]: assert.ok(self.idling) Jan 17 19:24:27 volumio volumio[9363]: error: The expression evaluated to a falsy value: Jan 17 19:24:27 volumio volumio[9363]: assert.ok(self.idling) Jan 17 19:24:27 volumio volumio[9363]: error: MPD error: The expression evaluated to a falsy value: Jan 17 19:24:27 volumio volumio[9363]: assert.ok(self.idling) Jan 17 19:24:27 volumio volumio[9363]: error: The expression evaluated to a falsy value: Jan 17 19:24:27 volumio volumio[9363]: assert.ok(self.idling) Jan 17 19:24:27 volumio volumio[9363]: info: Starting Shairport Sync Jan 17 19:24:27 volumio volumio[9363]: error: updateQueue error: null Jan 17 19:24:27 volumio sudo[9573]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart shairport-sync Jan 17 19:24:27 volumio sudo[9573]: pam_unix(sudo:session): session opened for user root by (uid=0) Jan 17 19:24:27 volumio systemd[1]: Stopping Shairport Sync - AirPlay Audio Receiver... Jan 17 19:24:27 volumio systemd[1]: shairport-sync.service: Succeeded. Jan 17 19:24:27 volumio systemd[1]: Stopped Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:27 volumio systemd[1]: shairport-sync.service: Start request repeated too quickly. Jan 17 19:24:27 volumio systemd[1]: shairport-sync.service: Failed with result 'start-limit-hit'. Jan 17 19:24:27 volumio systemd[1]: Failed to start Shairport Sync - AirPlay Audio Receiver. Jan 17 19:24:27 volumio sudo[9573]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:27 volumio volumio[9363]: info: Shairport-sync error: Error: Command failed: /usr/bin/sudo /bin/systemctl restart shairport-sync Jan 17 19:24:27 volumio volumio[9363]: Job for shairport-sync.service failed. Jan 17 19:24:27 volumio volumio[9363]: See "systemctl status shairport-sync.service" and "journalctl -xe" for details. Jan 17 19:24:27 volumio volumio[9363]: info: Discovery: adding db590945-5fbf-4bfa-8882-0bd01dc22477 Jan 17 19:24:27 volumio volumio[9363]: info: Discovery: Found device Volumio Jan 17 19:24:27 volumio volumio[9363]: info: CoreCommandRouter::volumioGetState Jan 17 19:24:27 volumio volumio[9363]: info: CorePlayQueue::getTrack 0 Jan 17 19:24:29 volumio sudo[9401]: pam_unix(sudo:session): session closed for user root Jan 17 19:24:31 volumio volumio[9363]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:24:31 volumio volumio[9363]: TypeError: Cannot read property 'off' of undefined Jan 17 19:24:31 volumio volumio[9363]: at FusionDsp.onStop (/data/plugins/audio_interface/fusiondsp/index.js:107:15) Jan 17 19:24:31 volumio volumio[9363]: at PluginManager.stopPlugin (/volumio/app/pluginmanager.js:460:30) Jan 17 19:24:31 volumio volumio[9363]: at PluginManager.disableAndStopPlugin (/volumio/app/pluginmanager.js:1883:8) Jan 17 19:24:31 volumio volumio[9363]: at CoreCommandRouter.disableAndStopPlugin (/volumio/app/index.js:1551:29) Jan 17 19:24:31 volumio volumio[9363]: at Socket. (/volumio/app/plugins/user_interface/websocket/index.js:1395:47) Jan 17 19:24:31 volumio volumio[9363]: at Socket.emit (events.js:400:28) Jan 17 19:24:31 volumio volumio[9363]: at /volumio/node_modules/socket.io/lib/socket.js:528:12 Jan 17 19:24:31 volumio volumio[9363]: at processTicksAndRejections (internal/process/task_queues.js:77:11) Jan 17 19:24:31 volumio volumio[9363]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Jan 17 19:24:31 volumio sudo[9588]: volumio : TTY=unknown ; PWD=/ ; USER=root ; COMMAND=/bin/journalctl --since=2025-01-17 19:23 Jan 17 19:24:31 volumio sudo[9588]: pam_unix(sudo:session): session opened for user root by (uid=0) PRETTY_NAME="Debian GNU/Linux 10 (buster)" NAME="Debian GNU/Linux" VERSION_ID="10" VERSION="10 (buster)" VERSION_CODENAME=buster ID=debian HOME_URL="https://www.debian.org/" SUPPORT_URL="https://www.debian.org/support" BUG_REPORT_URL="https://bugs.debian.org/" VOLUMIO_BUILD_VERSION="70bcab5180cf11352f5a5197ade215ea8ee93db0" VOLUMIO_FE_VERSION="e7cae168f9927391640a091813b8a9656b6909b6" VOLUMIO_FE3_VERSION="df82a8f23c90a3617c15c55572c8aaea90d8b32a" VOLUMIO_BE_VERSION="678d37490b3eb2102ce7c6d7a6dc3cf042ff2347" VOLUMIO_ARCH="x64" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Fri 08 Nov 2024 07:25:16 PM CET" VOLUMIO_VERSION="3.779" VOLUMIO_HARDWARE="x86_amd64" VOLUMIO_DEVICENAME="x86_64" VOLUMIO_HASH="66c567362bdbb3dc1644a18f7879afe7"