Mar 24 16:39:00 dac-pi volumio[1525]: info: gpio-buttons: Initialized Mar 24 16:39:00 dac-pi volumio[1525]: info: Loading plugin "gpio_button_led"... Mar 24 16:39:00 dac-pi volumio[1525]: gpiox_arm32 V2.2.1 Mar 24 16:39:01 dac-pi volumio[1525]: info: Loading plugin "now_playing"... Mar 24 16:39:01 dac-pi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 4. Mar 24 16:39:01 dac-pi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:01 dac-pi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:02 dac-pi upmpdcli[1779]: Could not open config: /tmp/upmpdcli.conf Mar 24 16:39:02 dac-pi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 16:39:02 dac-pi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 16:39:07 dac-pi volumio[1525]: info: Loading plugin "outputs"... Mar 24 16:39:07 dac-pi volumio[1525]: info: Loading plugin "albumart"... Mar 24 16:39:07 dac-pi volumio[1525]: info: Plugin example_plugin is not enabled Mar 24 16:39:07 dac-pi volumio[1525]: info: Loading plugin "inputs"... Mar 24 16:39:07 dac-pi volumio[1525]: info: Loading plugin "updater_comm"... Mar 24 16:39:08 dac-pi volumio[1525]: info: Plugin mpdemulation is not enabled Mar 24 16:39:08 dac-pi volumio[1525]: info: Loading plugin "rest_api"... Mar 24 16:39:08 dac-pi volumio[1525]: info: Loading plugin "websocket"... Mar 24 16:39:08 dac-pi volumio[1525]: info: Starting Socket.io Server version 1.7.4 Mar 24 16:39:08 dac-pi volumio[1525]: info: Loading plugin "minidlna"... Mar 24 16:39:08 dac-pi volumio[1525]: info: Applying required configuration parameters for plugin minidlna Mar 24 16:39:09 dac-pi volumio[1525]: info: Loading plugin "radio_paradise"... Mar 24 16:39:10 dac-pi volumio[1525]: info: Applying required configuration parameters for plugin radio_paradise Mar 24 16:39:10 dac-pi volumio[1525]: info: [1774381150990] [RadioParadise] API delay: 5 Mar 24 16:39:11 dac-pi volumio[1525]: info: Loading plugin "backup_restore"... Mar 24 16:39:12 dac-pi volumio[1794]: Forking 3 albumart workers Mar 24 16:39:12 dac-pi volumio-remote-updater[664]: [2026-03-24 16:39:12] [connect] Successful connection Mar 24 16:39:13 dac-pi volumio[1525]: info: Applying required configuration parameters for plugin backup_restore Mar 24 16:39:13 dac-pi volumio[1525]: info: Loading plugin "mpd_oled"... Mar 24 16:39:17 dac-pi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 5. Mar 24 16:39:17 dac-pi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:17 dac-pi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:17 dac-pi upmpdcli[1848]: Could not open config: /tmp/upmpdcli.conf Mar 24 16:39:17 dac-pi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 16:39:17 dac-pi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 16:39:17 dac-pi volumio[1525]: info: Applying required configuration parameters for plugin mpd_oled Mar 24 16:39:17 dac-pi volumio[1525]: info: [MPD_OLED Plugin] Reading configuration file at: /data/configuration/system_hardware/mpd_oled/config.json Mar 24 16:39:18 dac-pi volumio[1525]: info: Loading plugin "rotaryencoder2"... Mar 24 16:39:26 dac-pi volumio[1525]: info: Loading plugin "Systeminfo"... Mar 24 16:39:27 dac-pi volumio-remote-updater[664]: [2026-03-24 16:39:27] [connect] Successful connection Mar 24 16:39:31 dac-pi volumio[1805]: Starting albumart workers Mar 24 16:39:31 dac-pi volumio[1804]: Starting albumart workers Mar 24 16:39:32 dac-pi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 6. Mar 24 16:39:32 dac-pi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:32 dac-pi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:32 dac-pi upmpdcli[1863]: Could not open config: /tmp/upmpdcli.conf Mar 24 16:39:32 dac-pi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 16:39:32 dac-pi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 16:39:33 dac-pi volumio[1525]: info: Loading plugin "randomizer"... Mar 24 16:39:33 dac-pi volumio[1806]: Starting albumart workers Mar 24 16:39:38 dac-pi volumio[1525]: info: Applying required configuration parameters for plugin randomizer Mar 24 16:39:41 dac-pi volumio[1525]: info: Loading i18n strings for locale pt Mar 24 16:39:41 dac-pi volumio[1525]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Mar 24 16:39:41 dac-pi volumio[1525]: Updating browse sources language Mar 24 16:39:41 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 16:39:42 dac-pi volumio-remote-updater[664]: [2026-03-24 16:39:42] [connect] Successful connection Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::initPlayerControls Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 16:39:43 dac-pi volumio[1525]: Express server listening on port 3000 Mar 24 16:39:43 dac-pi volumio[1525]: [Metrics] WebUI: 71s 35.77ms Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreStateMachine::resetVolumioState Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreStateMachine::getcurrentVolume Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreCommandRouter::volumioRetrievevolume Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreStateMachine::pushState Mar 24 16:39:44 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreCommandRouter::volumioPushState Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreCommandRouter::volumioRetrieveVolumeLevels Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreStateMachine::getcurrentVolume Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreCommandRouter::volumioRetrievevolume Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreStateMachine::pushState Mar 24 16:39:44 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:44 dac-pi volumio[1525]: info: CoreCommandRouter::volumioPushState Mar 24 16:39:44 dac-pi volumio[1525]: error: gpio-buttons: Socket connection error: undefined Mar 24 16:39:45 dac-pi volumio[1525]: info: Volumio Network Manager: Network status updated: 2 Mar 24 16:39:47 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 16:39:47 dac-pi volumio[1525]: info: Reloading queue from file Mar 24 16:39:47 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 16:39:47 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 16:39:47 dac-pi volumio[1525]: info: Discovery: Getting this device information Mar 24 16:39:47 dac-pi volumio[1525]: info: CoreCommandRouter::volumioGetState Mar 24 16:39:47 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:47 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 16:39:47 dac-pi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 7. Mar 24 16:39:47 dac-pi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:47 dac-pi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:39:48 dac-pi upmpdcli[1920]: Could not open config: /tmp/upmpdcli.conf Mar 24 16:39:48 dac-pi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 16:39:48 dac-pi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 16:39:48 dac-pi volumio[1525]: verbose: New Socket.io Connection to 192.168.1.101:3000 from 192.168.1.73 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 1 Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreStateMachine::setRepeat false single undefined Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreStateMachine::pushState Mar 24 16:39:48 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreCommandRouter::volumioPushState Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreStateMachine::setRandom true Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreStateMachine::pushState Mar 24 16:39:48 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , saveDeviceInfo Mar 24 16:39:48 dac-pi volumio[1525]: info: CoreCommandRouter::volumioPushState Mar 24 16:39:48 dac-pi volumio[1525]: info: Setting Device type: Raspberry PI Mar 24 16:39:48 dac-pi volumio[1525]: info: USB Boot Capable - Checking Install to Disk functions for: bootusb Mar 24 16:39:48 dac-pi volumio[1525]: info: USB Boot Capable - System SBC Revision found in cpuinfo: a52082 Mar 24 16:39:48 dac-pi volumio[1525]: info: USB Boot Capable - Found matching device in SBC capable list: Raspberry PI Mar 24 16:39:48 dac-pi volumio[1525]: info: Completed loading Core Plugins Mar 24 16:39:48 dac-pi volumio[1525]: info: Preparing to generate the ALSA configuration file Mar 24 16:39:49 dac-pi volumio[1525]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Mar 24 16:39:49 dac-pi volumio[1525]: info: Reading ALSA contributions from plugins. Mar 24 16:39:49 dac-pi volumio[1525]: info: Discovery: adding 610b1086-e212-4b9a-9659-b89851773d7e Mar 24 16:39:49 dac-pi volumio[1525]: info: Discovery: Found device DAC-PI Mar 24 16:39:49 dac-pi volumio[1525]: info: CoreCommandRouter::volumioGetState Mar 24 16:39:49 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:49 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 16:39:49 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 16:39:49 dac-pi volumio[1525]: info: Discovery: Getting this device information Mar 24 16:39:49 dac-pi volumio[1525]: info: CoreCommandRouter::volumioGetState Mar 24 16:39:49 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:49 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 16:39:49 dac-pi volumio[1525]: verbose: New Socket.io Connection to 192.168.1.101:3000 from 192.168.1.73 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 2 Mar 24 16:39:50 dac-pi volumio[1525]: info: Discovery: this is already registered, 610b1086-e212-4b9a-9659-b89851773d7e Mar 24 16:39:50 dac-pi volumio[1525]: info: Discovery: Found device DAC-PI Mar 24 16:39:50 dac-pi volumio[1525]: info: CoreCommandRouter::volumioGetState Mar 24 16:39:50 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:50 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemInfo Mar 24 16:39:50 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: volumiodiscovery , getThisDevice Mar 24 16:39:50 dac-pi volumio[1525]: info: Discovery: Getting this device information Mar 24 16:39:50 dac-pi volumio[1525]: info: CoreCommandRouter::volumioGetState Mar 24 16:39:50 dac-pi volumio[1525]: info: CorePlayQueue::getTrack 0 Mar 24 16:39:50 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: network , getCachedIPAddresses Mar 24 16:39:50 dac-pi volumio[1525]: verbose: New Socket.io Connection to 192.168.1.101:3000 from 192.168.1.73 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 3 Mar 24 16:39:51 dac-pi volumio[1525]: verbose: New Socket.io Connection to 192.168.1.101:3000 from 192.168.1.73 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 4 Mar 24 16:39:51 dac-pi volumio[1525]: verbose: New Socket.io Connection to 192.168.1.101:3000 from 192.168.1.73 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 5 Mar 24 16:39:52 dac-pi volumio[1525]: info: Asound.conf file unchanged, so no further update is needed Mar 24 16:39:52 dac-pi volumio[1525]: info: Output device has changed, restarting MPD Mar 24 16:39:52 dac-pi volumio[1525]: info: Output device has changed, restarting Shairport Sync Mar 24 16:39:52 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:52 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 16:39:52 dac-pi sudo[1924]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 24 16:39:52 dac-pi sudo[1924]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:39:52 dac-pi sudo[1924]: pam_unix(sudo:session): session closed for user root Mar 24 16:39:52 dac-pi sudo[1926]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 24 16:39:52 dac-pi volumio[1525]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 24 16:39:52 dac-pi sudo[1926]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:39:52 dac-pi volumio[1525]: info: ___________ START PLUGINS ___________ Mar 24 16:39:53 dac-pi volumio[1525]: info: ControllerMpd::onStart: Initializing MPD Mar 24 16:39:53 dac-pi volumio[1525]: info: Creating MPD Configuration file Mar 24 16:39:53 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: mpd , getConfigParam Mar 24 16:39:53 dac-pi volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 16:39:53 dac-pi systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 24 16:39:53 dac-pi volumio[1525]: info: [1774381193315] CoreMusicLibrary::Adding element Servidores multimédia Mar 24 16:39:53 dac-pi systemd[1]: Starting mpd.service - Music Player Daemon... Mar 24 16:39:53 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 16:39:53 dac-pi sudo[1937]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl restart mpd.service Mar 24 16:39:53 dac-pi sudo[1937]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:39:53 dac-pi systemd[1]: mpd.service: Deactivated successfully. Mar 24 16:39:53 dac-pi systemd[1]: Stopped mpd.service - Music Player Daemon. Mar 24 16:39:53 dac-pi systemd[1]: mpd.socket: Deactivated successfully. Mar 24 16:39:53 dac-pi systemd[1]: Closed mpd.socket - Music Player Daemon Socket. Mar 24 16:39:53 dac-pi systemd[1]: Stopping mpd.socket - Music Player Daemon Socket... Mar 24 16:39:53 dac-pi sudo[1934]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod 777 /etc/mpd.conf Mar 24 16:39:53 dac-pi sudo[1934]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:39:53 dac-pi systemd[1]: Listening on mpd.socket - Music Player Daemon Socket. Mar 24 16:39:53 dac-pi sudo[1934]: pam_unix(sudo:session): session closed for user root Mar 24 16:39:53 dac-pi systemd[1]: Starting mpd.service - Music Player Daemon... Mar 24 16:39:53 dac-pi volumio[1525]: info: UPNP Browser: Client initialized successfully Mar 24 16:39:53 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:53 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 16:39:54 dac-pi sudo[1942]: root : PWD=/ ; USER=root ; COMMAND=/bin/chown mpd:audio /var/log/mpd.log Mar 24 16:39:54 dac-pi sudo[1942]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=0) Mar 24 16:39:54 dac-pi sudo[1947]: /bin/chown: cannot access '/var/log/mpd.log': No such file or directory Mar 24 16:39:54 dac-pi sudo[1942]: pam_unix(sudo:session): session closed for user root Mar 24 16:39:54 dac-pi volumio[1525]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 24 16:39:54 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:39:54 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 16:39:54 dac-pi volumio[1525]: info: Could not detect Primo: Error: Command failed: aplay -l | grep es90x8q2m-dac-dai-0 Mar 24 16:39:54 dac-pi volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 16:39:54 dac-pi volumio[1525]: info: [1774381194819] CoreMusicLibrary::Adding element Last_100 Mar 24 16:39:54 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 16:39:54 dac-pi volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 16:39:54 dac-pi volumio[1525]: info: [1774381194869] CoreMusicLibrary::Adding element Webradio Mar 24 16:39:54 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 16:39:55 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 24 16:39:55 dac-pi volumio[1525]: info: Initializing BBC Radios Mar 24 16:39:55 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getSystemVersion Mar 24 16:39:55 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 16:39:56 dac-pi volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 16:39:56 dac-pi volumio[1525]: info: [1774381196962] CoreMusicLibrary::Adding element YouTube Music Mar 24 16:39:56 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 16:39:56 dac-pi volumio[1525]: Cannot find translation for source YouTube Music Mar 24 16:39:57 dac-pi volumio[1525]: info: gpio-buttons: Creating GPIO triggers... Mar 24 16:39:57 dac-pi volumio[1525]: info: gpio-buttons: GPIO16 configured: button1 -> next Mar 24 16:39:57 dac-pi volumio[1525]: info: gpio-buttons: GPIO26 configured: button2 -> previous Mar 24 16:39:57 dac-pi volumio[1525]: info: gpio-buttons: GPIO22 configured: button3 -> playPause Mar 24 16:39:57 dac-pi volumio[1525]: info: GPIOButtonLED: Starting plugin Mar 24 16:39:57 dac-pi volumio[1525]: info: [now-playing] ConfigUpdater: config is up to date. Mar 24 16:39:57 dac-pi volumio-remote-updater[664]: [2026-03-24 16:39:57] [connect] Successful connection Mar 24 16:39:57 dac-pi volumio[1525]: info: Loading i18n strings for locale pt Mar 24 16:39:58 dac-pi volumio[1525]: error: minidlna: Fetching language file: Error: i18n file complementing the system language not found. Mar 24 16:39:58 dac-pi volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 16:39:58 dac-pi volumio[1525]: info: [1774381198411] CoreMusicLibrary::Adding element Radio Paradise Mar 24 16:39:58 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 16:39:58 dac-pi volumio[1525]: Cannot find translation for source YouTube Music Mar 24 16:39:58 dac-pi volumio[1525]: Cannot find translation for source Radio Paradise Mar 24 16:39:58 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , updateALSAConfigFile Mar 24 16:39:59 dac-pi sudo[1991]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start mpd_oled_plugin.service Mar 24 16:39:59 dac-pi sudo[1990]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/chmod +x /tmp/mpd_oled_plugin.sh Mar 24 16:39:59 dac-pi sudo[1991]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:39:59 dac-pi sudo[1990]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:39:59 dac-pi sudo[1990]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:00 dac-pi sudo[1995]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay -l Mar 24 16:40:00 dac-pi sudo[1995]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:40:00 dac-pi volumio[1525]: info: CoreCommandRouter::volumioAddToBrowseSources[object Object] Mar 24 16:40:00 dac-pi volumio[1525]: info: [1774381200939] CoreMusicLibrary::Adding element Randomizer Mar 24 16:40:00 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: my_music , getDisabledSources Mar 24 16:40:00 dac-pi volumio[1525]: Cannot find translation for source YouTube Music Mar 24 16:40:00 dac-pi volumio[1525]: Cannot find translation for source Radio Paradise Mar 24 16:40:00 dac-pi volumio[1525]: Cannot find translation for source Randomizer Mar 24 16:40:01 dac-pi volumio[1525]: info: Volumio Calling Home Mar 24 16:40:01 dac-pi sudo[1995]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:02 dac-pi volumio[1525]: info: gpio-buttons: Started successfully Mar 24 16:40:02 dac-pi volumio[1525]: info: Preparing to generate the ALSA configuration file Mar 24 16:40:03 dac-pi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 8. Mar 24 16:40:03 dac-pi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:40:03 dac-pi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:40:03 dac-pi upmpdcli[2000]: Could not open config: /tmp/upmpdcli.conf Mar 24 16:40:03 dac-pi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 16:40:03 dac-pi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 16:40:06 dac-pi mpd[1948]: 2026-03-24T16:40:06 decoder: Decoder plugin "wildmidi" is unavailable: configuration file does not exist: /etc/timidity/timidity.cfg Mar 24 16:40:06 dac-pi systemd[1]: Started mpd.service - Music Player Daemon. Mar 24 16:40:06 dac-pi sudo[1937]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:06 dac-pi sudo[1926]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:06 dac-pi (lugin.sh)[2017]: mpd_oled_plugin.service: Failed to execute /tmp/mpd_oled_plugin.sh: Text file busy Mar 24 16:40:06 dac-pi systemd[1]: Started mpd_oled_plugin.service - MPD OLED Plugin. Mar 24 16:40:06 dac-pi (lugin.sh)[2017]: mpd_oled_plugin.service: Failed at step EXEC spawning /tmp/mpd_oled_plugin.sh: Text file busy Mar 24 16:40:06 dac-pi systemd[1]: mpd_oled_plugin.service: Main process exited, code=exited, status=203/EXEC Mar 24 16:40:06 dac-pi systemd[1]: mpd_oled_plugin.service: Failed with result 'exit-code'. Mar 24 16:40:06 dac-pi sudo[1991]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:08 dac-pi volumio[1525]: info: [now-playing] App is listening on port 4004. Mar 24 16:40:08 dac-pi volumio[1525]: warn: [now-playing] MyBackgroundMonitor is now watching /data/INTERNAL/NowPlayingPlugin/My Backgrounds Mar 24 16:40:08 dac-pi volumio[1525]: verbose: New Socket.io Connection to 192.168.1.101:3000 from 192.168.1.73 UA: Dart/3.10 (dart:io) Engine version: 3 Transport: websocket Total Clients: 6 Mar 24 16:40:09 dac-pi volumio[1525]: error: gpio-buttons: Socket connection error: undefined Mar 24 16:40:09 dac-pi volumio[1525]: info: The plugin mpd_oled has an ALSA contribution file volumioalsa.postalsa.5.conf Mar 24 16:40:09 dac-pi volumio[1525]: info: Reading ALSA contributions from plugins. Mar 24 16:40:09 dac-pi volumio[1525]: info: [MPD_OLED Plugin] Started mpd_oled_plugin service Mar 24 16:40:09 dac-pi volumio[1525]: info: [MPD_OLED Plugin] Set execute permissions on /tmp/mpd_oled_plugin.sh Mar 24 16:40:09 dac-pi volumio[1525]: info: minidlna: Found miniDLNA version 1.3.0 Mar 24 16:40:09 dac-pi volumio[1525]: info: minidlna: Starting minidlna.service Mar 24 16:40:10 dac-pi sudo[2019]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay rotary-encoder pin_a=23 pin_b=24 relative_axis=true steps-per-period=2 Mar 24 16:40:10 dac-pi volumio[1525]: info: MPD Permissions set Mar 24 16:40:10 dac-pi sudo[2019]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:40:10 dac-pi sudo[2021]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/systemctl start minidlna.service Mar 24 16:40:10 dac-pi sudo[2021]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:40:10 dac-pi sudo[2019]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:10 dac-pi volumio[1525]: info: MPD Permissions set Mar 24 16:40:10 dac-pi kernel: rotary-encoder rotary@17: gray Mar 24 16:40:10 dac-pi kernel: input: rotary@17 as /devices/platform/rotary@17/input/input1 Mar 24 16:40:10 dac-pi systemd[1]: Started minidlna.service - MiniDLNA lightweight DLNA/UPnP-AV server. Mar 24 16:40:10 dac-pi sudo[2021]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:11 dac-pi volumio[1525]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 7 Mar 24 16:40:11 dac-pi volumio[1525]: info: MPD running with PID1948 Mar 24 16:40:11 dac-pi volumio[1525]: ,establishing connection Mar 24 16:40:11 dac-pi volumio[1525]: info: minidlna: systemctl start minidlna.service succeeded. Mar 24 16:40:11 dac-pi volumio[1525]: info: Volumio called home Mar 24 16:40:12 dac-pi volumio[1525]: info: [MPD_OLED Plugin] tmp script created /tmp/mpd_oled_plugin.sh Mar 24 16:40:12 dac-pi volumio-remote-updater[664]: [2026-03-24 16:40:12] [connect] Successful connection Mar 24 16:40:15 dac-pi volumio[1525]: error: MPD error: The expression evaluated to a falsy value: Mar 24 16:40:15 dac-pi volumio[1525]: assert.ok(self.idling) Mar 24 16:40:15 dac-pi volumio[1525]: error: The expression evaluated to a falsy value: Mar 24 16:40:15 dac-pi volumio[1525]: assert.ok(self.idling) Mar 24 16:40:15 dac-pi volumio[1525]: error: MPD error: The expression evaluated to a falsy value: Mar 24 16:40:15 dac-pi volumio[1525]: assert.ok(self.idling) Mar 24 16:40:15 dac-pi volumio[1525]: error: The expression evaluated to a falsy value: Mar 24 16:40:15 dac-pi volumio[1525]: assert.ok(self.idling) Mar 24 16:40:17 dac-pi volumio[1525]: verbose: New Socket.io Connection to localhost:3000 from 127.0.0.1 UA: node-XMLHttpRequest Engine version: 3 Transport: polling Total Clients: 8 Mar 24 16:40:17 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:17 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:17 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:17 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi sudo[2056]: volumio : PWD=/ ; USER=root ; COMMAND=/usr/bin/dtoverlay gpio-key gpio=27 active_low=true gpio_pull=up keycode=20 Mar 24 16:40:18 dac-pi sudo[2056]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) Mar 24 16:40:18 dac-pi kernel: input: button@1b as /devices/platform/button@1b/input/input2 Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi sudo[2056]: pam_unix(sudo:session): session closed for user root Mar 24 16:40:18 dac-pi volumio[1525]: info: GPIOButtonLED: dtoverlay already correct Mar 24 16:40:18 dac-pi volumio[1525]: info: GPIOButtonLED: LED+ on GPIO 14 Mar 24 16:40:18 dac-pi volumio[1525]: info: GPIOButtonLED: LED polarity = normal Mar 24 16:40:18 dac-pi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 9. Mar 24 16:40:18 dac-pi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:40:18 dac-pi volumio[1525]: info: GPIOButtonLED: LED blink slow Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:18 dac-pi upmpdcli[2070]: Could not open config: /tmp/upmpdcli.conf Mar 24 16:40:18 dac-pi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 16:40:18 dac-pi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 16:40:19 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: system , getConfigParam Mar 24 16:40:19 dac-pi volumio[1525]: info: CoreCommandRouter::executeOnPlugin: alsa_controller , getConfigParam Mar 24 16:40:19 dac-pi volumio[1525]: |||||||||||||||||||||||| WARNING: FATAL ERROR ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 16:40:19 dac-pi volumio[1525]: Error: Unable to resolve or reject the same promise twice Mar 24 16:40:19 dac-pi volumio[1525]: at Promise.resolve (/data/plugins/system_hardware/rotaryencoder2/node_modules/kew/kew.js:140:43) Mar 24 16:40:19 dac-pi volumio[1525]: at /data/plugins/system_hardware/rotaryencoder2/index.js:1017:23 Mar 24 16:40:19 dac-pi volumio[1525]: at FSReqCallback.oncomplete (node:fs:190:23) Mar 24 16:40:19 dac-pi volumio[1525]: ||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||||| Mar 24 16:40:27 dac-pi volumio-remote-updater[664]: [2026-03-24 16:40:27] [connect] Successful connection Mar 24 16:40:33 dac-pi systemd[1]: upmpdcli.service: Scheduled restart job, restart counter is at 10. Mar 24 16:40:33 dac-pi systemd[1]: Stopped upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:40:33 dac-pi systemd[1]: Started upmpdcli.service - UPnP Renderer front-end to MPD. Mar 24 16:40:34 dac-pi upmpdcli[2102]: Could not open config: /tmp/upmpdcli.conf Mar 24 16:40:34 dac-pi systemd[1]: upmpdcli.service: Main process exited, code=exited, status=1/FAILURE Mar 24 16:40:34 dac-pi systemd[1]: upmpdcli.service: Failed with result 'exit-code'. Mar 24 16:40:34 dac-pi sudo[2105]: volumio : PWD=/ ; USER=root ; COMMAND=/bin/journalctl '--since=2026-03-24 16:39' Mar 24 16:40:34 dac-pi sudo[2105]: pam_unix(sudo:session): session opened for user root(uid=0) by (uid=1000) PRETTY_NAME="Raspbian GNU/Linux 12 (bookworm)" NAME="Raspbian GNU/Linux" VERSION_ID="12" VERSION="12 (bookworm)" VERSION_CODENAME=bookworm ID=raspbian ID_LIKE=debian HOME_URL="http://www.raspbian.org/" SUPPORT_URL="http://www.raspbian.org/RaspbianForums" BUG_REPORT_URL="http://www.raspbian.org/RaspbianBugs" VOLUMIO_BUILD_VERSION="b05a530ca81d05eb9a84d0acf82089f0a60b8ee6" VOLUMIO_FE_VERSION="35f8f4439f0076a62fefa72fd80b70701b3d6cbd" VOLUMIO_FE3_VERSION="bcca17b6b6b26edfb999e6fd7da1b222a88a61d2" VOLUMIO_BE_VERSION="4ad85e2147d972f0b838d33c21382d2d813b2ae8" VOLUMIO_ARCH="arm" VOLUMIO_VARIANT="volumio" VOLUMIO_TEST="FALSE" VOLUMIO_BUILD_DATE="Thu Dec 25 09:13:19 UTC 2025" VOLUMIO_VERSION="4.084" VOLUMIO_HARDWARE="pi" VOLUMIO_DEVICENAME="Raspberry Pi" VOLUMIO_HASH="792f09af7488531aecd1aadcaa9b175e"